Brute Force Prevention

Test duration: 14.833s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.130s
2019-11-20 20:16:18 |

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

2019-11-20 20:16:18 | ------------------------------------

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@773f238d

2019-11-20 20:16:18 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@4c263b5e}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@79f8d31a}, 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@7dc748fd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@38c5d921}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3668a6ff}, 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 20 20:16:18 PST 2019}}}}

2019-11-20 20:16:18 | [Mutex] waiting for: [registration]

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@937c32b

2019-11-20 20:16:18 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@79f8d31a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@7dc748fd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@38c5d921}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3668a6ff}, 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 20 20:16:18 PST 2019}}}}

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@4e70e250

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

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

2019-11-20 20:16:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@58ea266e}

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

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

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2bc62cd2

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1c5f9c1a

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

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

2019-11-20 20:16:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@55748fa3}

2019-11-20 20:16:18 | user :: null >> <iq to="localhost" id="BxSKXgXcQMQX2qQNClIBwwq" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-20 20:16:18 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@dd38e380}

2019-11-20 20:16:18 | user :: null << <iq id="BxSKXgXcQMQX2qQNClIBwwq" xmlns="jabber:client" type="result" from="localhost"><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-20 20:16:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5ca41a35}

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@461e1dcf

2019-11-20 20:16:18 | user :: null >> <iq to="localhost" id="hpsZ07gHIUcBFPUT6gGn07n" type="set"><query xmlns="jabber:iq:register"><username>user_ux57tm0027</username><password>user_ux57tm0027</password><email>18e4f704-e2c3-4807-a775-da69436237a4@localhost</email></query></iq>

2019-11-20 20:16:18 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2de5df81}

2019-11-20 20:16:18 | [Mutex] received everything.

2019-11-20 20:16:18 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-20 20:16:18 | user :: null << <iq id="hpsZ07gHIUcBFPUT6gGn07n" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-20 20:16:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@26c1f65a}

2019-11-20 20:16:18 | 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;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@58ea266e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@55748fa3]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@79f8d31a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@7dc748fd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@38c5d921}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3668a6ff}, 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 20 20:16:18 PST 2019}}}}

2019-11-20 20:16:18 | 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;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@58ea266e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@55748fa3]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@79f8d31a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@7dc748fd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@38c5d921}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3668a6ff}, 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 20 20:16:18 PST 2019}}}}

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@57b97cb6

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2b30a1c6

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1df6310a

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@342c67c8

2019-11-20 20:16:18 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@286ce137

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

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1xZkZuTWs4SkhUdnZocjVhdGtoRQ==</auth>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xZkZuTWs4SkhUdnZocjVhdGtoRXp2SEd1eDN1d2p4cFc1eDdaejBULHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cWZGbk1rOEpIVHZ2aHI1YXRraEV6dkhHdXgzdXdqeHBXNXg3WnowVCxwPUtMY3lLcFhZOFh1M0l1eW1xV1paTXN2cG5PK3Uxd1VxWStnRTFCaXpTcE09</response>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zY2FNajZnVlZLTytFVVF6VXZtbHZkUThDRlc5WFVYaXRYNGIvczBMOENVPQ==</success>

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

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost >> <iq xmlns="jabber:client" id="qD6DLMDAeCfKBlIT8HGOIIH" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost << <iq id="qD6DLMDAeCfKBlIT8HGOIIH" xmlns="jabber:client" to="user_ux57tm0027@localhost/993927746-tigase-19" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_ux57tm0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="AyPLyzup6Eo4pWes14fwdKY" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost/993927746-tigase-19 << <iq id="AyPLyzup6Eo4pWes14fwdKY" xmlns="jabber:client" to="user_ux57tm0027@localhost/993927746-tigase-19" type="result"/>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="AzQNCHKV8IwkVYiAhAhAl0u" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost/993927746-tigase-19 << <enabled resume="true" id="3bc094f1-f2ec-4780-87f2-f0f9620b486f" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60"/>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost/993927746-tigase-19 >> <iq id="MPA8nMFmT6GKHRdGrcs49yd" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 20:16:18 | user :: user_ux57tm0027@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-20 20:16:18 | user :: user_ux57tm0027@localhost/993927746-tigase-19 << <iq id="AzQNCHKV8IwkVYiAhAhAl0u" xmlns="jabber:client" to="user_ux57tm0027@localhost/993927746-tigase-19" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><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:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-20 20:16:18 | user :: user_ux57tm0027@localhost/993927746-tigase-19 << <iq id="MPA8nMFmT6GKHRdGrcs49yd" xmlns="jabber:client" to="user_ux57tm0027@localhost/993927746-tigase-19" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 20:16:18 | Disconnecting

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

2019-11-20 20:16:18 | [Mutex] notify: [disconnected]

2019-11-20 20:16:18 | [Mutex] received everything.

2019-11-20 20:16:19 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj04eXAzeFlMWUdZWVVjcG40d1ZtRA==</auth>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04eXAzeFlMWUdZWVVjcG40d1ZtRGtKTFdVcjliWkdBeUxXUnFZOHZRLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OHlwM3hZTFlHWVlVY3BuNHdWbURrSkxXVXI5YlpHQXlMV1JxWTh2USxwPUNxY1ppSzBCOUNZU2ZaR0l1eHkwMW1tRDZQenBySzZvZ1B2V1ZwckVUYXc9</response>

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

2019-11-20 20:16:19 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:19 | [Mutex] received everything.

2019-11-20 20:16:19 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:19 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1HdXVZVWw0RHU4RkVlTE5OTUE1cw==</auth>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HdXVZVWw0RHU4RkVlTE5OTUE1c3lUYTFGNjZ6eng2WkdOU1EzWlVrLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R3V1WVVsNER1OEZFZUxOTk1BNXN5VGExRjY2enp4NlpHTlNRM1pVayxwPVhVOEp0djdYZi9PZG1taW1VcnBkLytjZHEzMlE3eVBIK0JsS25zQnYxK0U9</response>

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

2019-11-20 20:16:19 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:19 | [Mutex] received everything.

2019-11-20 20:16:19 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:19 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj0zdUM4NlFMZUREN2ZwTnNzbTRacw==</auth>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zdUM4NlFMZUREN2ZwTnNzbTRac2tQT3ZqdU13ZkZCallYR3M1a0RtLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M3VDODZRTGVERDdmcE5zc200WnNrUE92anVNd2ZGQmpZWEdzNWtEbSxwPWhPMkhJTVlNNkZZNXo1SW9uTTRPZFBHT01BTXJ2R0tBbXNURmdmYWtuVEU9</response>

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

2019-11-20 20:16:19 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:19 | [Mutex] received everything.

2019-11-20 20:16:19 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:19 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1RMGkweThSNjc3OTFoY1lzTkdJQg==</auth>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RMGkweThSNjc3OTFoY1lzTkdJQnQ0U3M0VmZOV3Z5T09mRzNYV0E4LHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UTBpMHk4UjY3NzkxaGNZc05HSUJ0NFNzNFZmTld2eU9PZkczWFdBOCxwPVZVZzduLytxUlZPV2VSaUttK2x4QU5oVlVDZXlCNlk1bG1ib2h1SWNxdkk9</response>

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

2019-11-20 20:16:19 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:19 | [Mutex] received everything.

2019-11-20 20:16:19 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:19 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1rWGNTbjRqSzZlcTdzTTNQelRDUg==</auth>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rWGNTbjRqSzZlcTdzTTNQelRDUllGQm5aV3BQeEdmdUg2ZHF5MXp0LHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a1hjU240aks2ZXE3c00zUHpUQ1JZRkJuWldwUHhHZnVINmRxeTF6dCxwPWJtdHZUa1JaTkxpREFsRlN6T050TmtWZWU5WWpqdmMreGpUS0ZPYU1UTms9</response>

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

2019-11-20 20:16:19 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:19 | [Mutex] received everything.

2019-11-20 20:16:19 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:19 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1sQ2NZMmVyaGJYYXdzWjU5eE9zbg==</auth>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sQ2NZMmVyaGJYYXdzWjU5eE9zbnlpRlN5VjdQOEFnUElXMTdHQW5BLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bENjWTJlcmhiWGF3c1o1OXhPc255aUZTeVY3UDhBZ1BJVzE3R0FuQSxwPUY4RGNIQWpLeW1kcU9xak1idmhkL285ejNvckJHaTNSMzFRUDdqVU00OGs9</response>

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

2019-11-20 20:16:19 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:19 | [Mutex] received everything.

2019-11-20 20:16:19 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:19 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj13Q0hTYVFqdG5iaXhmZUp6bW04UQ==</auth>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13Q0hTYVFqdG5iaXhmZUp6bW04UVZibGFqbFJ2eVJjRzR2d1cySVZQLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d0NIU2FRanRuYml4ZmVKem1tOFFWYmxhamxSdnlSY0c0dndXMklWUCxwPXNaMVYzSWZ6V1F3dnVCU21hYlFIdjg0ZzRTWUl6ai9qMWxhY3hGTE8xM2s9</response>

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

2019-11-20 20:16:19 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:19 | [Mutex] notify: [event, disconnected]

2019-11-20 20:16:19 | [Mutex] received everything.

2019-11-20 20:16:19 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:19 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1TdTFQSmxDSmhQdnNtempKS2hpVQ==</auth>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TdTFQSmxDSmhQdnNtempKS2hpVUZBaUNpVDZPWDREemJCQ3Y4Snl6LHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U3UxUEpsQ0poUHZzbXpqSktoaVVGQWlDaVQ2T1g0RHpiQkN2OEp5eixwPW1CSlYrRDlab3J5K2g0a2hPSytKU3JiUW9RTFFqUFoxc3JQcXNLV0F3UU09</response>

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

2019-11-20 20:16:19 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:19 | [Mutex] received everything.

2019-11-20 20:16:19 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:19 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj0xZFNwNzBOREdMRXNuR2JxcFpFNA==</auth>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xZFNwNzBOREdMRXNuR2JxcFpFNFZtZWpHVmZPbllRcWdPb1lINXBFLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MWRTcDcwTkRHTEVzbkdicXBaRTRWbWVqR1ZmT25ZUXFnT29ZSDVwRSxwPTRwSkFEY0V2ZXJ5amh2bGViSEJRUUU1cGJaaHkrTUZsMXhwK3g0QTc4NEE9</response>

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

2019-11-20 20:16:19 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:19 | [Mutex] received everything.

2019-11-20 20:16:19 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:19 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:19 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1Wc1dIM1BQZnRENHVJUEZ1VEg0SA==</auth>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Wc1dIM1BQZnRENHVJUEZ1VEg0SE9UOTlCZ3lhUHNTaWRrUlJMSmROLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VnNXSDNQUGZ0RDR1SVBGdVRINEhPVDk5Qmd5YVBzU2lka1JSTEpkTixwPTJMVjVVSERmaU1idldUQ09xanV0elpEYWJHazA3RkhKQU53YTNqT2NNdWM9</response>

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

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

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

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

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

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

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

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

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1sa1d3bkFScGNvRlpVR1Q2cGszZA==</auth>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sa1d3bkFScGNvRlpVR1Q2cGszZHo4eWgxNFNYNE5vSW1Na240SXJILHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bGtXd25BUnBjb0ZaVUdUNnBrM2R6OHloMTRTWDROb0ltTWtuNElySCxwPTRSUmFPQTRhc1RtbG0ycUtHVWh4UnErYktCZ3kzSHJTSGJURzJmdzhXUUU9</response>

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

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

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

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

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

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

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

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

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1lV05Hd0JDZ2p2TDhCMnF6MjlHUA==</auth>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lV05Hd0JDZ2p2TDhCMnF6MjlHUDJPcGxXRUFVOWdJRzAxWjNCYm5yLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZVdOR3dCQ2dqdkw4QjJxejI5R1AyT3BsV0VBVTlnSUcwMVozQmJucixwPVA0bTMzQSt6YUhBSDh1M0p3UFhJRFBvZVhHT3E2WnlBNmRIYmNZcFNid009</response>

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

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

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

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

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

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

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

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

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1VSFBWZlRPOVZONnhFbTFyVVBVMg==</auth>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VSFBWZlRPOVZONnhFbTFyVVBVMm9PRnpROGhTWmxPdTlFV1RQUzFOLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VUhQVmZUTzlWTjZ4RW0xclVQVTJvT0Z6UThoU1psT3U5RVdUUFMxTixwPWcyZStDUkYwdmp2N21jcWI5VXdGRmpSU2ljYW0xR0FZRDN3bVRFZU1KeWc9</response>

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

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

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

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

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

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

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

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

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1MQ1JwdER5MVhiVXhqTVNMQUZTUA==</auth>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MQ1JwdER5MVhiVXhqTVNMQUZTUGphMlhvUWxYMEljZ2ZpTXNEcUdSLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TENScHREeTFYYlV4ak1TTEFGU1BqYTJYb1FsWDBJY2dmaU1zRHFHUixwPVh3RGhqYS9EQXgzdjg4NzhmWklQV1ZkZ0FpejFwaGpTajdPR1F1NlAzWXM9</response>

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

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

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

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

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

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

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

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

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1sWVdlMDhXa0FkMXFKamxxZkxzaA==</auth>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sWVdlMDhXa0FkMXFKamxxZkxzaG13RXNudkhqZ0RxTThDZElaNm1VLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bFlXZTA4V2tBZDFxSmpscWZMc2htd0VzbnZIamdEcU04Q2RJWjZtVSxwPThEcVNtZVpacU5XY0hBd04rM09MT1RKWVJUQUVRV1hYWlR5MVVRdm91Z2M9</response>

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

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

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

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

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

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

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

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

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1JNXVKYUU5QUtOSVBiWHd1M3BHbg==</auth>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JNXVKYUU5QUtOSVBiWHd1M3BHbnloTk9KSkNsQnRHRlpOdWlVdlFqLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9STV1SmFFOUFLTklQYlh3dTNwR255aE5PSkpDbEJ0R0ZaTnVpVXZRaixwPUM2SzFNaGpEYndZbC8vZlQ4dlNOcS90N3RxSTRXeWV3WjI3U1FTS0UxaEk9</response>

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

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

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

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

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

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

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

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

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj11RVltRFhUVkxBc0UwZDJabFRYaQ==</auth>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11RVltRFhUVkxBc0UwZDJabFRYaTNPVmM1ZEVjT29oNmNKU1VqUFlILHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dUVZbURYVFZMQXNFMGQyWmxUWGkzT1ZjNWRFY09vaDZjSlNValBZSCxwPUZMUit3amVTdFhZVmU3MXVxa0lFNmZIaHFHVUEvbTV0Y3NsaFpkY3NiMXM9</response>

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

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

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

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

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

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

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

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

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj03STZEcUsxYU4zVUx5NXNQejdGRQ==</auth>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03STZEcUsxYU4zVUx5NXNQejdGRWRwdlkxcDVLTW1jQWFLc3ZTZ3JsLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N0k2RHFLMWFOM1VMeTVzUHo3RkVkcHZZMXA1S01tY0FhS3N2U2dybCxwPW9YUzJGODRjcDc4RUVlTHhTYXB5Q3BMNFJucUQxYTRwc3Zud1kwcGtycGc9</response>

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

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

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

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

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

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

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

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

2019-11-20 20:16:20 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj0xc2xtYmkzN09vTWNndVBTYnVIRQ==</auth>

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xc2xtYmkzN09vTWNndVBTYnVIRVd4ZUJJYXE1M2VuSnd3TkFTdFRHLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MXNsbWJpMzdPb01jZ3VQU2J1SEVXeGVCSWFxNTNlbkp3d05BU3RURyxwPXpLeHNUeXA4YnJDR2JmcWcweWtjWTlZYlJjMWxEK3RyZkFGeXU2amJIaG89</response>

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

2019-11-20 20:16:21 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:21 | [Mutex] received everything.

2019-11-20 20:16:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:21 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1FMVZrT2VoUjB1NVhvZlJ1enRSUA==</auth>

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FMVZrT2VoUjB1NVhvZlJ1enRSUHlRaEc0OGNqdFNJdHZ1WjFCTDhELHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RTFWa09laFIwdTVYb2ZSdXp0UlB5UWhHNDhjanRTSXR2dVoxQkw4RCxwPWFVaTN1aEFJSTRIaHFmUUNob0VNMG9iVk45VXBrOFdsZytkZTFVUUVTWlE9</response>

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

2019-11-20 20:16:21 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:21 | [Mutex] notify: [event, disconnected]

2019-11-20 20:16:21 | [Mutex] received everything.

2019-11-20 20:16:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:21 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1YWWJpOEF0U2puQ25DRGZUZG5WTQ==</auth>

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YWWJpOEF0U2puQ25DRGZUZG5WTXdaSGptYTNlZjFVaWNhdE5CeTcyLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WFliaThBdFNqbkNuQ0RmVGRuVk13WkhqbWEzZWYxVWljYXROQnk3MixwPWlxaG5ERkFraXMyTTd4alRWemhsdzNVSFNPZERHL1RwaHpIZU8vMjA2ZWs9</response>

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

2019-11-20 20:16:21 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:21 | [Mutex] received everything.

2019-11-20 20:16:21 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3V4NTd0bTAwMjcscj1wdUNsSWx3c0ZrMGF1SEN4NXZ2UA==</auth>

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wdUNsSWx3c0ZrMGF1SEN4NXZ2UDY5NmxZNGduUkhBWm00RzFteEZXLHM9dWZwZEhBS2M0RXBtYUE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:21 | user :: user_ux57tm0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cHVDbElsd3NGazBhdUhDeDV2dlA2OTZsWTRnblJIQVptNEcxbXhGVyxwPXFXZDR6aTJPSjdmK0orMWFucWJ5WnhPTnc3d1d4ZFpCUTRPektJRnVhWU09</response>

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

2019-11-20 20:16:23 | [Mutex] waiting for: [user]

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

2019-11-20 20:16:23 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.303s
2019-11-20 20:16:23 |

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

2019-11-20 20:16:23 | ------------------------------------

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@455983af

2019-11-20 20:16:23 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@4c263b5e}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b9e6574}, 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@4fa1e8df}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@aa36f4f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3eed14f}, 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 20 20:16:23 PST 2019}}}}

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

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3be3a183

2019-11-20 20:16:23 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b9e6574}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@4fa1e8df}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@aa36f4f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3eed14f}, 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 20 20:16:23 PST 2019}}}}

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@7b444130

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

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

2019-11-20 20:16:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6a8c9000}

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

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

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1f9d40b7

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@39d4057e

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

2019-11-20 20:16:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@60408eb5}

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

2019-11-20 20:16:23 | user :: null >> <iq to="localhost" id="ESDFCGscFsgw9kLyhSeQTfZ" type="get"><query xmlns="jabber:iq:register"/></iq>

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

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

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1b2f63ba

2019-11-20 20:16:23 | user :: null >> <iq to="localhost" id="1H47u5jELSbEKAsbukEpQNC" type="set"><query xmlns="jabber:iq:register"><username>user_1y575x0028</username><password>user_1y575x0028</password><email>c5a20961-09bc-4eea-8549-a954e89fe884@localhost</email></query></iq>

2019-11-20 20:16:23 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@197c662d}

2019-11-20 20:16:23 | user :: null << <iq id="1H47u5jELSbEKAsbukEpQNC" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-20 20:16:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2496a54}

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

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

2019-11-20 20:16:23 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6a8c9000, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@60408eb5]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b9e6574}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@4fa1e8df}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@aa36f4f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3eed14f}, 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 20 20:16:23 PST 2019}}}}

2019-11-20 20:16:23 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6a8c9000, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@60408eb5]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b9e6574}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@4fa1e8df}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@aa36f4f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3eed14f}, 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 20 20:16:23 PST 2019}}}}

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6698698e

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1855b016

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@78073215

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@31d5ec8b

2019-11-20 20:16:23 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@14a43726

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzF5NTc1eDAwMjgscj1xV1VnblhVYnFMdXJKdU9BQUE1Qg==</auth>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xV1VnblhVYnFMdXJKdU9BQUE1Qm1PZk04aURxdG01Nkg2MjFnSEpyLHM9dkwxSDk4MUhabVIxbmc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cVdVZ25YVWJxTHVySnVPQUFBNUJtT2ZNOGlEcXRtNTZINjIxZ0hKcixwPXFtYWROTkpOaGY1aUZ0c0xlb09rdXUwRjFaZ1MzWlNVTGlVOWZHc3lPd0E9</response>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1RTVhHR1B5TTFPaFRXRzlFM3NlTTI2ZDR5R3htbStjSHduRk54MzA2YXZnPQ==</success>

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <iq xmlns="jabber:client" id="5H24Byxmaq8xcKu5cv2fO6A" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost << <iq id="5H24Byxmaq8xcKu5cv2fO6A" xmlns="jabber:client" to="user_1y575x0028@localhost/993927746-tigase-20" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_1y575x0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="zPoRRKXgXcQMQX2qQNClIBw" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost/993927746-tigase-20 << <iq id="zPoRRKXgXcQMQX2qQNClIBw" xmlns="jabber:client" to="user_1y575x0028@localhost/993927746-tigase-20" type="result"/>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="hADlIx6n4CCrlbCjWW25qX3" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost/993927746-tigase-20 << <enabled resume="true" id="741ccc4d-59a2-4623-8d78-1366a0bb9330" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60"/>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost/993927746-tigase-20 >> <iq id="H304q7m48nMFmT6GKHRdGrc" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 20:16:24 | user :: user_1y575x0028@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-20 20:16:24 | user :: user_1y575x0028@localhost/993927746-tigase-20 << <iq id="hADlIx6n4CCrlbCjWW25qX3" xmlns="jabber:client" to="user_1y575x0028@localhost/993927746-tigase-20" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><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:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost/993927746-tigase-20 << <iq id="H304q7m48nMFmT6GKHRdGrc" xmlns="jabber:client" to="user_1y575x0028@localhost/993927746-tigase-20" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 20:16:24 | Disconnecting

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

2019-11-20 20:16:24 | [Mutex] notify: [disconnected]

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

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

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzF5NTc1eDAwMjgscj1LS01mcWRreE5Xb3VSbEM2RVJ6bw==</auth>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LS01mcWRreE5Xb3VSbEM2RVJ6bzJUUUlmcnVXMDBOajRlUTd3ZVA2LHM9dkwxSDk4MUhabVIxbmc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S0tNZnFka3hOV291UmxDNkVSem8yVFFJZnJ1VzAwTmo0ZVE3d2VQNixwPUgwMjhsVjUxZXF6VXZKSVhqRWU4ZXh6dWNsdEppRDdOVFAzRWlmY2hVUlU9</response>

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

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

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

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

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

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzF5NTc1eDAwMjgscj14aTNiN2l2bE94emJWZnMzd3h0cw==</auth>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14aTNiN2l2bE94emJWZnMzd3h0c0twdko0aU5BR1U4bTRpbUpHenR5LHM9dkwxSDk4MUhabVIxbmc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eGkzYjdpdmxPeHpiVmZzM3d4dHNLcHZKNGlOQUdVOG00aW1KR3p0eSxwPXcyR3E1SGlreCtRMEdpbmtTQkpSNFU2a2NFWDhWTlVFRGllYUxidTl0OGM9</response>

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

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

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

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

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

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

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzF5NTc1eDAwMjgscj01Y3A2RVpqMFFxQ0JObDdwVVU4OQ==</auth>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01Y3A2RVpqMFFxQ0JObDdwVVU4OUV4aldKTzlaS0NLa2lkNjZqUVBwLHM9dkwxSDk4MUhabVIxbmc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NWNwNkVaajBRcUNCTmw3cFVVODlFeGpXSk85WktDS2tpZDY2alFQcCxwPTlBNTh2aVU0UEs1UkxHSHhwb2F1dWMxL0VpMVNycTVTYVUySUY3ano1aXc9</response>

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

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

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

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

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

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

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzF5NTc1eDAwMjgscj16TmtYd2VoMWNmNkJhejBSOFFlbg==</auth>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16TmtYd2VoMWNmNkJhejBSOFFlbmNrMVdPMzcwbkJDc1podzI1bElzLHM9dkwxSDk4MUhabVIxbmc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ek5rWHdlaDFjZjZCYXowUjhRZW5jazFXTzM3MG5CQ3NaaHcyNWxJcyxwPUNLL0dGNHZIeUdYenVaNjUxK0puMkVoa1R5WUVSWE9LSHdtbDg0VGVaVms9</response>

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

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

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

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

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzF5NTc1eDAwMjgscj1PbGE5MEpicjNseVlYZHQ4YlZLMQ==</auth>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PbGE5MEpicjNseVlYZHQ4YlZLMXFlVGZGRE1XT0w0WjZjc1M2Um1hLHM9dkwxSDk4MUhabVIxbmc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:24 | user :: user_1y575x0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T2xhOTBKYnIzbHlZWGR0OGJWSzFxZVRmRkRNV09MNFo2Y3NTNlJtYSxwPU0xRnUvT3RpeTJWZEU2dm80Mng4QlVJTVhLbWh5ZkQ0Vjk3emMyT3hTMTQ9</response>

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

2019-11-20 20:16:26 | [Mutex] waiting for: [user]

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

2019-11-20 20:16:26 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.112s
2019-11-20 20:16:26 |

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

2019-11-20 20:16:26 | ------------------------------------

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

2019-11-20 20:16:26 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@24653d56}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@205aad02}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6558376d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@59f5ece2}, 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 20 20:16:26 PST 2019}}}}

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

2019-11-20 20:16:26 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@54f7f507

2019-11-20 20:16:26 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@24653d56}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@205aad02}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6558376d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@59f5ece2}, 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 20 20:16:26 PST 2019}}}}

2019-11-20 20:16:26 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@21b07026

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

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

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

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

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

2019-11-20 20:16:26 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@7393a692

2019-11-20 20:16:26 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@18273a2a

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

2019-11-20 20:16:27 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3ab45848}

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

2019-11-20 20:16:27 | user :: null >> <iq to="localhost" id="jGNFmT6GKHRdGrcs49ydzaN" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-20 20:16:27 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@314048c8}

2019-11-20 20:16:27 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@139b1e4

2019-11-20 20:16:27 | user :: null << <iq id="jGNFmT6GKHRdGrcs49ydzaN" xmlns="jabber:client" type="result" from="localhost"><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-20 20:16:27 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6f703067}

2019-11-20 20:16:27 | user :: null >> <iq to="localhost" id="TZGO0dThOHIu8hOJBeVcPWk" type="set"><query xmlns="jabber:iq:register"><username>user_pdujg30029</username><password>user_pdujg30029</password><email>e7d46949-6a10-4e9b-967a-7d3d5db537ca@localhost</email></query></iq>

2019-11-20 20:16:27 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1ecff3a7}

2019-11-20 20:16:27 | user :: null << <iq id="TZGO0dThOHIu8hOJBeVcPWk" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-20 20:16:27 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4e27a1c9}

2019-11-20 20:16:27 | [Mutex] received everything.

2019-11-20 20:16:27 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-20 20:16:27 | 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;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@577c822, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3ab45848]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@24653d56}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@205aad02}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6558376d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@59f5ece2}, 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 20 20:16:27 PST 2019}}}}

2019-11-20 20:16:27 | 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;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@577c822, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3ab45848]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@24653d56}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@205aad02}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6558376d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@59f5ece2}, 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 20 20:16:27 PST 2019}}}}

2019-11-20 20:16:27 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@56c9d65d

2019-11-20 20:16:27 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1a33fbf1

2019-11-20 20:16:27 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@742e03d8

2019-11-20 20:16:27 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7f4dd7d

2019-11-20 20:16:27 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1f9798e0

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BkdWpnMzAwMjkscj1Nc3F2QUllOEZMRzZuSGJDQVZSQw==</auth>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Nc3F2QUllOEZMRzZuSGJDQVZSQ3NsSHFWSWNyQzNSWEkzVVBrVXROLHM9Vm5ydmdDUEJJSVM5SlE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TXNxdkFJZThGTEc2bkhiQ0FWUkNzbEhxVkljckMzUlhJM1VQa1V0TixwPTgyRkpHTmJReE45akoxWVpvUUFMemg2OXY0L281cUZobisrUWptZmhXSEk9</response>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1UUkl2bTJvTzV1dmhqb1ZtNzhXQmJDa3E2a3FUc0piaHplN3Jvd1RLenRZPQ==</success>

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <iq xmlns="jabber:client" id="X98JIvkIAbClPGP0raMEAr0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost/993927746-tigase-21 << <iq id="WUnbRY1mMIr8nTO5wteUU6t" xmlns="jabber:client" to="user_pdujg30029@localhost/993927746-tigase-21" type="result"/>

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

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost/993927746-tigase-21 << <enabled resume="true" id="8d5c9346-6cb2-47c3-b303-9dbda4306143" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60"/>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost/993927746-tigase-21 >> <iq id="9a5qiGEzgSKBezavk8Evtr8" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 20:16:27 | user :: user_pdujg30029@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-20 20:16:27 | user :: user_pdujg30029@localhost/993927746-tigase-21 << <iq id="0MX25qX38JO3oeyo3eOClIx" xmlns="jabber:client" to="user_pdujg30029@localhost/993927746-tigase-21" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><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:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost/993927746-tigase-21 << <iq id="9a5qiGEzgSKBezavk8Evtr8" xmlns="jabber:client" to="user_pdujg30029@localhost/993927746-tigase-21" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 20:16:27 | Disconnecting

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

2019-11-20 20:16:27 | [Mutex] notify: [disconnected]

2019-11-20 20:16:27 | [Mutex] received everything.

2019-11-20 20:16:27 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BkdWpnMzAwMjkscj1HaXRSZmljYkNKRlpUYTBBUGxQdA==</auth>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HaXRSZmljYkNKRlpUYTBBUGxQdFBmaW51OFg4Q3pPUTRXbGx3UjhFLHM9Vm5ydmdDUEJJSVM5SlE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R2l0UmZpY2JDSkZaVGEwQVBsUHRQZmludThYOEN6T1E0V2xsd1I4RSxwPWE4LzF1TisxeU5CTTdWYnU2YmFBL3FpbjgrNDNYQllpdDY3SGROcHdFZG89</response>

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

2019-11-20 20:16:27 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:27 | [Mutex] notify: [event, disconnected]

2019-11-20 20:16:27 | [Mutex] received everything.

2019-11-20 20:16:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:27 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BkdWpnMzAwMjkscj1XZDVvck5YWjVJT1p2M1ZwZGVUdA==</auth>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XZDVvck5YWjVJT1p2M1ZwZGVUdGNZWXBHRFZHdHRKTUFwenpsc3N0LHM9Vm5ydmdDUEJJSVM5SlE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V2Q1b3JOWFo1SU9adjNWcGRlVHRjWVlwR0RWR3R0Sk1BcHp6bHNzdCxwPXBKMy8xR09GcndvOGR5Q3M3c0xSdmQ5blRrOVVDUmMrSlVDMmQzbGV6Rk09</response>

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

2019-11-20 20:16:27 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:27 | [Mutex] received everything.

2019-11-20 20:16:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:27 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BkdWpnMzAwMjkscj1jYkEyMW9qUXRtY1JaTTRYSUlMdw==</auth>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jYkEyMW9qUXRtY1JaTTRYSUlMd2hQOVY0SnRNdTJSaGlISVY2djlwLHM9Vm5ydmdDUEJJSVM5SlE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y2JBMjFvalF0bWNSWk00WElJTHdoUDlWNEp0TXUyUmhpSElWNnY5cCxwPURMTEhVMzdQcmtBNUFYWU9uSXlVK0wzNHE4L204RG9Xd1lWKzI3MjlwNFE9</response>

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

2019-11-20 20:16:27 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:27 | [Mutex] received everything.

2019-11-20 20:16:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:27 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BkdWpnMzAwMjkscj1QRW5wYkx2Z1BqSXBmT3ZmQ0pDYQ==</auth>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QRW5wYkx2Z1BqSXBmT3ZmQ0pDYXJ3MDNwZEJzYmhpUjJ0aURzWkU4LHM9Vm5ydmdDUEJJSVM5SlE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UEVucGJMdmdQaklwZk92ZkNKQ2FydzAzcGRCc2JoaVIydGlEc1pFOCxwPWkzUlg2NGNYd2VSeXJ4MGRLRC9OMFIvRE9wbGkwbk9xblhSSUpnR2ZJSUk9</response>

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

2019-11-20 20:16:27 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:27 | [Mutex] received everything.

2019-11-20 20:16:27 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-20 20:16:27 | user :: user_pdujg30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:28 | user :: user_pdujg30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BkdWpnMzAwMjkscj1aSmt0dzFMU1BTQnVFM2ZPQ21lVw==</auth>

2019-11-20 20:16:28 | user :: user_pdujg30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aSmt0dzFMU1BTQnVFM2ZPQ21lV09SdzROd29uS1REWE5tbFFSYVd5LHM9Vm5ydmdDUEJJSVM5SlE9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:28 | user :: user_pdujg30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WkprdHcxTFNQU0J1RTNmT0NtZVdPUnc0TndvbktURFhObWxRUmFXeSxwPUJFQ0Fnam9HYk1oc0dQaDVTcDVwY2wySUV4clpBT25VZ2RPUmFGbHRWU3c9</response>

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

2019-11-20 20:16:30 | [Mutex] waiting for: [user]

2019-11-20 20:16:30 | [Mutex] received everything.

2019-11-20 20:16:30 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.001s
2019-11-20 20:16:30 |

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

2019-11-20 20:16:30 | ------------------------------------

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@700d6aa7

2019-11-20 20:16:30 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@4c263b5e}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7eca8ad6}, 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@7af501d7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3ff780ed}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@24348de6}, 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 20 20:16:30 PST 2019}}}}

2019-11-20 20:16:30 | [Mutex] waiting for: [registration]

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@e823f8c

2019-11-20 20:16:30 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7eca8ad6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@7af501d7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3ff780ed}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@24348de6}, 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 20 20:16:30 PST 2019}}}}

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@5cab6c32

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

2019-11-20 20:16:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5fd87fa2}

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

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

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

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5f838202

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@4062b821

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

2019-11-20 20:16:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@47af86e3}

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

2019-11-20 20:16:30 | user :: null >> <iq to="localhost" id="COVhUfM06ufCAarUVSVaO0d" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-20 20:16:30 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e02ddd9e}

2019-11-20 20:16:30 | user :: null << <iq id="COVhUfM06ufCAarUVSVaO0d" xmlns="jabber:client" type="result" from="localhost"><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-20 20:16:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5b96c4db}

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@18c6ce39

2019-11-20 20:16:30 | user :: null >> <iq to="localhost" id="YilUT6gGn07nM1odISQYdys" type="set"><query xmlns="jabber:iq:register"><username>user_jh8saq0030</username><password>user_jh8saq0030</password><email>3a27411a-1380-42a7-baa2-7707bdefc2bd@localhost</email></query></iq>

2019-11-20 20:16:30 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f0b1b3b2}

2019-11-20 20:16:30 | user :: null << <iq id="YilUT6gGn07nM1odISQYdys" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-20 20:16:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4d30ceb0}

2019-11-20 20:16:30 | [Mutex] received everything.

2019-11-20 20:16:30 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-20 20:16:30 | 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;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5fd87fa2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@47af86e3]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7eca8ad6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@7af501d7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3ff780ed}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@24348de6}, 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 20 20:16:30 PST 2019}}}}

2019-11-20 20:16:30 | 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;@4c263b5e}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5fd87fa2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@47af86e3]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7eca8ad6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@d1b3165}, 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@7af501d7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3ff780ed}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@24348de6}, 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 20 20:16:30 PST 2019}}}}

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7693d16b

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1bce637e

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@35d7d138

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7ed9cc7c

2019-11-20 20:16:30 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@16a94245

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2poOHNhcTAwMzAscj1pY1hWM3J6RWpGUlV2TVp0UzQ4Tg==</auth>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pY1hWM3J6RWpGUlV2TVp0UzQ4Tk5SbDZTV0FFdG94Mk5wcW9ldmNOLHM9NVh6bVpBM216RnJlaWc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aWNYVjNyekVqRlJVdk1adFM0OE5OUmw2U1dBRXRveDJOcHFvZXZjTixwPUNjTUQ0cHg4MDd1Qi8yWVNwa0VEOCtnV25XQkVDZ0t0MXNwY3lkTkw2bWs9</response>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1BTzVreldZUWF1bzJ6VXhtMWI5VWlsVk5CM0F0cHYrT2Jtc3hwMFlPNEVzPQ==</success>

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <iq xmlns="jabber:client" id="34DlPGP0raMEAr0mIx6jEtg" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="kWdq1mcMLZtctgAkFAhHqjY" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost/993927746-tigase-22 << <iq id="kWdq1mcMLZtctgAkFAhHqjY" xmlns="jabber:client" to="user_jh8saq0030@localhost/993927746-tigase-22" type="result"/>

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

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost/993927746-tigase-22 << <enabled resume="true" id="7ef7d4dc-d1dc-48f1-95d6-71b6950a2645" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60"/>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost/993927746-tigase-22 >> <iq id="gdYUVSRKFEMW5DLMDAeCfKB" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 20:16:30 | user :: user_jh8saq0030@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-20 20:16:30 | user :: user_jh8saq0030@localhost/993927746-tigase-22 << <iq id="m1q8KSXnfKzsY6dGt5cR4zq" xmlns="jabber:client" to="user_jh8saq0030@localhost/993927746-tigase-22" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><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:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost/993927746-tigase-22 << <iq id="gdYUVSRKFEMW5DLMDAeCfKB" xmlns="jabber:client" to="user_jh8saq0030@localhost/993927746-tigase-22" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 20:16:30 | Disconnecting

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

2019-11-20 20:16:30 | [Mutex] notify: [disconnected]

2019-11-20 20:16:30 | [Mutex] received everything.

2019-11-20 20:16:30 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2poOHNhcTAwMzAscj1VdHhpQWI1YzJuM29VdXlUNjhJcQ==</auth>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VdHhpQWI1YzJuM29VdXlUNjhJcU9NVEZSN2poZjZBZExEMTdNWXpQLHM9NVh6bVpBM216RnJlaWc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VXR4aUFiNWMybjNvVXV5VDY4SXFPTVRGUjdqaGY2QWRMRDE3TVl6UCxwPWNqd0pudmpPdWx4UmhwZnRsRHB1UDZmdGhUTWNsKytsemQ2dDRZaUpnL2M9</response>

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

2019-11-20 20:16:30 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:30 | [Mutex] received everything.

2019-11-20 20:16:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:30 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2poOHNhcTAwMzAscj13QmRTdGFIWnFSWFVGelMza3A3OA==</auth>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13QmRTdGFIWnFSWFVGelMza3A3OHhQTXRRQWlWOGk2RE5JWTZhRk1ZLHM9NVh6bVpBM216RnJlaWc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d0JkU3RhSFpxUlhVRnpTM2twNzh4UE10UUFpVjhpNkROSVk2YUZNWSxwPWVHejdTZCsydTNRakRZTURyemdUY1hoUHdvbTJJWnB0b3Qvb0poK0pycWM9</response>

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

2019-11-20 20:16:30 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:30 | [Mutex] received everything.

2019-11-20 20:16:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 20:16:30 | [Mutex] waiting for: [event]

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2poOHNhcTAwMzAscj1tajZJUG1tNk5ZTXFFR1VwZ2VoUQ==</auth>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tajZJUG1tNk5ZTXFFR1VwZ2VoUVM2UXpNUmdqaE1zbXJSdVVFSDBJLHM9NVh6bVpBM216RnJlaWc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bWo2SVBtbTZOWU1xRUdVcGdlaFFTNlF6TVJnamhNc21yUnVVRUgwSSxwPVA2MWdNWTFyazQrQnVITXVPWmU0QlBPSkp2NE55bXNaNXgvRXNLWmZqUWM9</response>

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

2019-11-20 20:16:30 | [Mutex] notify: [event, authFailed]

2019-11-20 20:16:30 | [Mutex] received everything.

2019-11-20 20:16:30 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2poOHNhcTAwMzAscj1LbjYxQTZXN0VTNkhwdHZ4alFITA==</auth>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LbjYxQTZXN0VTNkhwdHZ4alFITFpyUnNGSGNRajBXbDV3NGNiM2FYLHM9NVh6bVpBM216RnJlaWc9PSxpPTQwOTY=</challenge>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S242MUE2VzdFUzZIcHR2eGpRSExaclJzRkhjUWowV2w1dzRjYjNhWCxwPTNGVHNSdFNmYkpjUXRzQkFwTng5V0o3d3V1U0hsd1NqSER4aVgvUzBhb289</response>

2019-11-20 20:16:30 | user :: user_jh8saq0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj12ODJXaTlsZHJFNWpyWUdsWnlsREd3emdnOGxsSW5zcDVJc0IwZHNYQTdjPQ==</success>

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

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

2019-11-20 20:16:31 | user :: user_jh8saq0030@localhost << <iq id="kZgwdKYkRbRY1mMIr8nTO5w" xmlns="jabber:client" to="user_jh8saq0030@localhost/993927746-tigase-23" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_jh8saq0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-20 20:16:31 | user :: user_jh8saq0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="jV29kPYqeFN5qVaoWT2bv2x" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-20 20:16:31 | user :: user_jh8saq0030@localhost/993927746-tigase-23 << <iq id="jV29kPYqeFN5qVaoWT2bv2x" xmlns="jabber:client" to="user_jh8saq0030@localhost/993927746-tigase-23" type="result"/>

2019-11-20 20:16:31 | user :: user_jh8saq0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="wY9qRY3fwvm9ACkW9qcoTOJ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-20 20:16:31 | user :: user_jh8saq0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-20 20:16:31 | user :: user_jh8saq0030@localhost/993927746-tigase-23 << <enabled resume="true" id="f1dd7690-ebc6-431a-bb68-5eceff8fabd5" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60"/>

2019-11-20 20:16:31 | user :: user_jh8saq0030@localhost/993927746-tigase-23 >> <iq id="ddQVYiAhAhAl0umVj7u3qUY" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 20:16:31 | user :: user_jh8saq0030@localhost/993927746-tigase-23 << <iq id="wY9qRY3fwvm9ACkW9qcoTOJ" xmlns="jabber:client" to="user_jh8saq0030@localhost/993927746-tigase-23" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><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:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-20 20:16:31 | user :: user_jh8saq0030@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-20 20:16:31 | user :: user_jh8saq0030@localhost/993927746-tigase-23 << <iq id="ddQVYiAhAhAl0umVj7u3qUY" xmlns="jabber:client" to="user_jh8saq0030@localhost/993927746-tigase-23" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 20:16:31 | Disconnecting

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

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

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

2019-11-20 20:16:33 | [Mutex] waiting for: [user]

2019-11-20 20:16:33 | [Mutex] received everything.

2019-11-20 20:16:33 | [Mutex] isItemNotified: user:ok:true :: true