Brute Force Prevention

2019-11-24 18:55:34 |

2019-11-24 18:55:34 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-24 18:55:34 | ------------------------------------

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1579db9f

2019-11-24 18:55:34 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1bbe2740}, 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@1f81b0ef}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5a832d7b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1fdb097}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:34 PST 2019}}}}

2019-11-24 18:55:34 | [Mutex] waiting for: [registration]

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6b1313cf

2019-11-24 18:55:34 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1bbe2740}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1f81b0ef}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5a832d7b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1fdb097}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:34 PST 2019}}}}

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@7987d08a

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

2019-11-24 18:55:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3aacd234}

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

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

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

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5639a4fe

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2547589d

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

2019-11-24 18:55:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6283df3f}

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

2019-11-24 18:55:34 | user :: null >> <iq to="localhost" id="prAbwh01jXWdyjHIMOTOYnX" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 18:55:34 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@bf890ec4}

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

2019-11-24 18:55:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3ee28c29}

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@25e7d15f

2019-11-24 18:55:34 | user :: null >> <iq to="localhost" id="3xQRNUaArUaLJGyeUXcHSXe" type="set"><query xmlns="jabber:iq:register"><username>user_luwrk50027</username><password>user_luwrk50027</password><email>d1b15ddb-566d-4619-93c4-c0cdadf6c94c@localhost</email></query></iq>

2019-11-24 18:55:34 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@656d3c09}

2019-11-24 18:55:34 | user :: null << <iq from="localhost" id="3xQRNUaArUaLJGyeUXcHSXe" xmlns="jabber:client" type="result"/>

2019-11-24 18:55:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3a7bf6ce}

2019-11-24 18:55:34 | [Mutex] received everything.

2019-11-24 18:55:34 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 18:55:34 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3aacd234, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6283df3f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1bbe2740}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1f81b0ef}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5a832d7b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1fdb097}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:34 PST 2019}}}}

2019-11-24 18:55:34 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3aacd234, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6283df3f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1bbe2740}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1f81b0ef}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5a832d7b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1fdb097}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:34 PST 2019}}}}

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@46fdbc99

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6cd4f3ab

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7722aa47

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@128aefeb

2019-11-24 18:55:34 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@39388057

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

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj10aTBhTm9mYXd2OGNYNEFNQm8xTw==</auth>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10aTBhTm9mYXd2OGNYNEFNQm8xT2JMczY5d1l2MG5ENVFnRzljQXFuLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dGkwYU5vZmF3djhjWDRBTUJvMU9iTHM2OXdZdjBuRDVRZ0c5Y0FxbixwPW0yOUdXbzBNdDFJbDk4MVpvOHJ2MGx2NHR3U0E3c3NCaWdoa00zV2NuaDQ9</response>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1YaVVkNkpyNTM4YnRSTjlIcG5mQlNSbHcrb2N5RHJXRzRiVzczdDdQMkFRPQ==</success>

2019-11-24 18:55:34 | user :: user_luwrk50027@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 hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="7etRvi08c1DSCAgh81QLOpuANqY="/></features>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost >> <iq xmlns="jabber:client" id="nKrSNDq5CfLRKPMLBwo2lIM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost << <iq id="nKrSNDq5CfLRKPMLBwo2lIM" xmlns="jabber:client" to="user_luwrk50027@localhost/993927746-tigase-19" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_luwrk50027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="WuDo1uZfPGHwfzsgMPGIRV4" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost/993927746-tigase-19 << <iq id="WuDo1uZfPGHwfzsgMPGIRV4" xmlns="jabber:client" to="user_luwrk50027@localhost/993927746-tigase-19" type="result"/>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost/993927746-tigase-19 >> <iq to="localhost" id="eGbwaMHGFOPYYZ1cDIr9DiV" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost/993927746-tigase-19 >> <iq id="qwFs9KvhTOX2hDAwiRKQ7r6" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost/993927746-tigase-19 << <enabled max="60" location="d4270859fb27" resume="true" id="3d222808-4827-4c53-91d6-85c420947457" xmlns="urn:xmpp:sm:3"/>

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

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost/993927746-tigase-19 << <iq id="qwFs9KvhTOX2hDAwiRKQ7r6" xmlns="jabber:client" to="user_luwrk50027@localhost/993927746-tigase-19" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:55:34 | Disconnecting

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

2019-11-24 18:55:34 | [Mutex] notify: [disconnected]

2019-11-24 18:55:34 | [Mutex] received everything.

2019-11-24 18:55:34 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj02ZW5BbmN6VzZSVkJFSmJncmlUQQ==</auth>

2019-11-24 18:55:34 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02ZW5BbmN6VzZSVkJFSmJncmlUQWs3NUN6eGJpNW1QS1k2TVNvb0NJLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NmVuQW5jelc2UlZCRUpiZ3JpVEFrNzVDenhiaTVtUEtZNk1Tb29DSSxwPTZHY2JjMTd0RkcvTG1ISXYyM1o2SE1mWVBwTXpKVW1iZ1RvMERsellBUVk9</response>

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

2019-11-24 18:55:35 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:35 | [Mutex] received everything.

2019-11-24 18:55:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:35 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1EczJ3R0piV2NHS0NrTHF2MzFkcA==</auth>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EczJ3R0piV2NHS0NrTHF2MzFkcGZkZmVkZXhHS1hCeEQ2cFIwZnFILHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RHMyd0dKYldjR0tDa0xxdjMxZHBmZGZlZGV4R0tYQnhENnBSMGZxSCxwPTB3YU9lYUlZektSdHpHSmF5a2FmQzh5M3o2TTlWOHdnK3dPbEQ1OC9WUWc9</response>

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

2019-11-24 18:55:35 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:35 | [Mutex] received everything.

2019-11-24 18:55:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:35 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1TSjlJWjJHMEtIRVIxRDUwREJ3VQ==</auth>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TSjlJWjJHMEtIRVIxRDUwREJ3VWpkdXFEZVpTOHZNejZiUkhLZ0VyLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U0o5SVoyRzBLSEVSMUQ1MERCd1VqZHVxRGVaUzh2TXo2YlJIS2dFcixwPUpmSGdpSU1IUFFIdS9ZWCtmbUxKMjloaWwrbTA4VU1pbVJEcm54TjNJeWc9</response>

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

2019-11-24 18:55:35 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:35 | [Mutex] received everything.

2019-11-24 18:55:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:35 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1KMm5kVW9YNFM5YTM3N3ZwQWdIbw==</auth>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KMm5kVW9YNFM5YTM3N3ZwQWdIb1pJYjJaRno3Z0h3aDh6b3F5dFV2LHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SjJuZFVvWDRTOWEzNzd2cEFnSG9aSWIyWkZ6N2dId2g4em9xeXRVdixwPTJMWmhSTzNmRmtIY0MxV1dEMVB6dG8raWhGcXdhTGpLNnorYlB2NDdiZjQ9</response>

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

2019-11-24 18:55:35 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:35 | [Mutex] received everything.

2019-11-24 18:55:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:35 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1RYXpDRExsOG92SzNaVUN6QTUySA==</auth>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RYXpDRExsOG92SzNaVUN6QTUySDI4T2hGMVhSdHIyakk2b282bGhxLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UWF6Q0RMbDhvdkszWlVDekE1MkgyOE9oRjFYUnRyMmpJNm9vNmxocSxwPUdwS3VCbndsb3MvQ0pCNmNlbk9Kc0tQNGNaYVVORGlaY1NMY1FFeVM1WGs9</response>

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

2019-11-24 18:55:35 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:35 | [Mutex] received everything.

2019-11-24 18:55:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:35 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1lcjVIbVd6Z2lZOWRBZzhRQXFORg==</auth>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lcjVIbVd6Z2lZOWRBZzhRQXFORmtMNFlnOTdVY3l0YWw4THgzUGk2LHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZXI1SG1XemdpWTlkQWc4UUFxTkZrTDRZZzk3VWN5dGFsOEx4M1BpNixwPTlWWldSTGpVeHdHTGVoR3lWazVSQ0Jod2VJSzQ4RFVxcDV5Rm16dTB2d0U9</response>

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

2019-11-24 18:55:35 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:35 | [Mutex] received everything.

2019-11-24 18:55:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:35 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj14eUpxanYzNHljOXRWclRnRjRoVw==</auth>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14eUpxanYzNHljOXRWclRnRjRoV1VxYWszdk5PeHVha2ZRVGMzZG1pLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eHlKcWp2MzR5Yzl0VnJUZ0Y0aFdVcWFrM3ZOT3h1YWtmUVRjM2RtaSxwPUJnamZGOXo3NDl2QmZ1UFVRc0FiUjhEOTlaM2RoTnFqSXkwQWpjenAvYkk9</response>

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

2019-11-24 18:55:35 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:35 | [Mutex] received everything.

2019-11-24 18:55:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:35 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1UeXJMZ25VZjhNdktrczdsQUJLMw==</auth>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UeXJMZ25VZjhNdktrczdsQUJLM0FZN3lHZXd6Q2tvdFY4dkxWU25OLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:35 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VHlyTGduVWY4TXZLa3M3bEFCSzNBWTd5R2V3ekNrb3RWOHZMVlNuTixwPVphQkZUeVc4aHA1OEp5NDVLaVpOWTFRRE5BWHNCbWJTL0Y2QVNBbDF5aGM9</response>

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

2019-11-24 18:55:35 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:35 | [Mutex] received everything.

2019-11-24 18:55:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:36 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1YWk92cXZXY1VHYlFjTDFyZlRiSQ==</auth>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YWk92cXZXY1VHYlFjTDFyZlRiSVpVaEtpRXdadXh0eW03TnBEczRPLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WFpPdnF2V2NVR2JRY0wxcmZUYklaVWhLaUV3WnV4dHltN05wRHM0TyxwPVVQWlJVdVpzcjV6TmZSSmthSXlXM1BYMjhSM0VaZWxkMDVuN2liaGF1UVk9</response>

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

2019-11-24 18:55:36 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:36 | [Mutex] received everything.

2019-11-24 18:55:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:36 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj15eVU2WGtCemNoNTA2Uno2aVR3Zg==</auth>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15eVU2WGtCemNoNTA2Uno2aVR3ZjRlV1pCNWhyQWl2Q200UVJkSkd2LHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eXlVNlhrQnpjaDUwNlJ6NmlUd2Y0ZVdaQjVockFpdkNtNFFSZEpHdixwPTI1Nm43QmJQQ21BaVJyQzQxSUdoVlF1Z2R4QTdHRzQ4bUp5dmNwUWNPY0k9</response>

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

2019-11-24 18:55:36 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:36 | [Mutex] received everything.

2019-11-24 18:55:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:36 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1VRDI4dUdSZGExN2xua1dERUNHRQ==</auth>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VRDI4dUdSZGExN2xua1dERUNHRXlweVlIRzRpWndvNUFnU1dBMDVGLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VUQyOHVHUmRhMTdsbmtXREVDR0V5cHlZSEc0aVp3bzVBZ1NXQTA1RixwPVJZS3Exd1NqaGpHYzdyVU9hRDBqeG00VlIrYmJWMVVpNHhPOGl6KzAvTHc9</response>

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

2019-11-24 18:55:36 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:36 | [Mutex] notify: [event, disconnected]

2019-11-24 18:55:36 | [Mutex] received everything.

2019-11-24 18:55:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:36 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj0wT1N2Rm5PdDRlck5idFNsOGFWMA==</auth>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wT1N2Rm5PdDRlck5idFNsOGFWMEFtRFpwZndTQnZDZ0VTQnhWekhKLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ME9TdkZuT3Q0ZXJOYnRTbDhhVjBBbURacGZ3U0J2Q2dFU0J4VnpISixwPUwyR21MUlNyN0swWnR2dWVINEk1VVE2RS9GWmtOODIzTkxsNTg4dXlvNjQ9</response>

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

2019-11-24 18:55:36 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:36 | [Mutex] received everything.

2019-11-24 18:55:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:36 | [Mutex] notify: [event, disconnected]

2019-11-24 18:55:36 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1wWkVicVFXclJqY1N0YmxselV5eA==</auth>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wWkVicVFXclJqY1N0YmxselV5eHJyT0Y4aW9xNWpPNUw3Q2VHN1FoLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cFpFYnFRV3JSamNTdGJsbHpVeXhyck9GOGlvcTVqTzVMN0NlRzdRaCxwPU15cEQxTG9WaWRJY0JIY3lyVVdoSnY3NWpKWHROWVpTbmJlNlpiN3VGcjQ9</response>

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

2019-11-24 18:55:36 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:36 | [Mutex] received everything.

2019-11-24 18:55:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:36 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1aOVVNRGlQcjhWN1YzbDZsUmdHMg==</auth>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aOVVNRGlQcjhWN1YzbDZsUmdHMlIzU0Q1ZE5jTTYzWGg3OVpIajNuLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WjlVTURpUHI4VjdWM2w2bFJnRzJSM1NENWROY002M1hoNzlaSGozbixwPSt4MlBtQUVXRjFNeGlFUEJJY013NmszeVBScFAvbHYxODRZTFZrK0Q0RE09</response>

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

2019-11-24 18:55:36 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:36 | [Mutex] received everything.

2019-11-24 18:55:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:36 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1pVFhtQXJ5eDI3RGNlYnpkWHY2VQ==</auth>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pVFhtQXJ5eDI3RGNlYnpkWHY2VU5hVnBybEhlUnVyN3lMMkdSa21ZLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aVRYbUFyeXgyN0RjZWJ6ZFh2NlVOYVZwcmxIZVJ1cjd5TDJHUmttWSxwPXZsTG41ZWdUQys2Z3U5QzRSd2tSZTZBS3QxUHpTYzVwck84MmVtaVNMbzg9</response>

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

2019-11-24 18:55:36 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:36 | [Mutex] received everything.

2019-11-24 18:55:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:36 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:36 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj16Qk1iQjBvRlpMSVlGZ3AxOUhoOQ==</auth>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16Qk1iQjBvRlpMSVlGZ3AxOUhoOUZJQzZzN21mUUNRUXBoc1o0U3RmLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ekJNYkIwb0ZaTElZRmdwMTlIaDlGSUM2czdtZlFDUVFwaHNaNFN0ZixwPVRkZzhtSFpnbGgwMVVPSzdEWDY2Z1c2YkVqVUI3Qml5THlmdUNUSHl2K009</response>

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

2019-11-24 18:55:37 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:37 | [Mutex] received everything.

2019-11-24 18:55:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:37 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1GeFFuNFRiWnh6NlFIdGo4WkVKYg==</auth>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GeFFuNFRiWnh6NlFIdGo4WkVKYjIya3drVHhwQ3IyZ2pEZ2E4THJjLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RnhRbjRUYlp4ejZRSHRqOFpFSmIyMmt3a1R4cENyMmdqRGdhOExyYyxwPW1ZZTBGOFNwbkpQdmFtbmNUYlg3amcvTldnUFV1YzV0NXdCZnVaY3lPa2c9</response>

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

2019-11-24 18:55:37 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:37 | [Mutex] received everything.

2019-11-24 18:55:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:37 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1EY1ZZV2trZXNJSVNTZXU1RDlhQg==</auth>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EY1ZZV2trZXNJSVNTZXU1RDlhQnY4WUFkNjA3TDBMYUNMaWxiVU5lLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RGNWWVdra2VzSUlTU2V1NUQ5YUJ2OFlBZDYwN0wwTGFDTGlsYlVOZSxwPVFOeWdodVFpYWlqa3ZCZWw0dnllQjR4RnBVb3BVcXdGaDJHT1VobHE0cUE9</response>

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

2019-11-24 18:55:37 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:37 | [Mutex] received everything.

2019-11-24 18:55:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:37 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1VSHh4alBobUtoNHluSGVIZUtLNA==</auth>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VSHh4alBobUtoNHluSGVIZUtLNGVDU2pYS0lKbVdOWGF2d2dlc2xFLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VUh4eGpQaG1LaDR5bkhlSGVLSzRlQ1NqWEtJSm1XTlhhdndnZXNsRSxwPXNaNXNFQWYweUd5TlZHVVgybTZjeDd3N1ZBRGxvTXpXT0VqelZ0c2c3c2M9</response>

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

2019-11-24 18:55:37 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:37 | [Mutex] received everything.

2019-11-24 18:55:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:37 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj1mZ2RBc1RkMWk5NjlhSU1iNEhmZA==</auth>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mZ2RBc1RkMWk5NjlhSU1iNEhmZHdaNW9YR29TQXdCdm5TbjRiVFJsLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZmdkQXNUZDFpOTY5YUlNYjRIZmR3WjVvWEdvU0F3QnZuU240YlRSbCxwPXVTcktlOFpnUE1BY0hxWjlEY3ZRL2FqeUpRMmtmV1ZhUmtKZk83d0ZrTk09</response>

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

2019-11-24 18:55:37 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:37 | [Mutex] received everything.

2019-11-24 18:55:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:37 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj15dUNZMlNpRzhrbXJGN1ZaMXlLbA==</auth>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15dUNZMlNpRzhrbXJGN1ZaMXlLbE1OdWlmZ2owVkdpcHBVVkVzdXlILHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eXVDWTJTaUc4a21yRjdWWjF5S2xNTnVpZmdqMFZHaXBwVVZFc3V5SCxwPUlLazBlbFpzUjlvTVl6MkxXTy9FRG4zWkp3c0EvNGw4RTJINnNmN3FrRW89</response>

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

2019-11-24 18:55:37 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:37 | [Mutex] received everything.

2019-11-24 18:55:37 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2x1d3JrNTAwMjcscj10cXZnek5GdkZBR1h4Y0V4dnQ5dQ==</auth>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10cXZnek5GdkZBR1h4Y0V4dnQ5dTZjOUt5eE1LTTByYW42ZkhEMUxSLHM9VWxPbmVvRy9PRGNzT0E9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:37 | user :: user_luwrk50027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dHF2Z3pORnZGQUdYeGNFeHZ0OXU2YzlLeXhNS00wcmFuNmZIRDFMUixwPXc3SDZINmRyc3p1NGlpSFVrTlpjRDI3NDVYdVIvZGx4aFJpY3ZJZ3Z1aG89</response>

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

2019-11-24 18:55:39 | [Mutex] waiting for: [user]

2019-11-24 18:55:39 | [Mutex] received everything.

2019-11-24 18:55:39 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-24 18:55:39 |

2019-11-24 18:55:39 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-24 18:55:39 | ------------------------------------

2019-11-24 18:55:39 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@16b204bc

2019-11-24 18:55:39 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1875e81a}, 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@1c4a6fcc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5948e221}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5fd99a50}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:39 PST 2019}}}}

2019-11-24 18:55:39 | [Mutex] waiting for: [registration]

2019-11-24 18:55:39 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@685b9c89

2019-11-24 18:55:39 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1875e81a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1c4a6fcc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5948e221}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5fd99a50}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:39 PST 2019}}}}

2019-11-24 18:55:39 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2720ba41

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

2019-11-24 18:55:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39671d6e}

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

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

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

2019-11-24 18:55:39 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2aff1b08

2019-11-24 18:55:39 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1e74750a

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

2019-11-24 18:55:40 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3c243637}

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

2019-11-24 18:55:40 | user :: null >> <iq to="localhost" id="qzIyl8hPZ0lOPJMU4pQ2vdE" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 18:55:40 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@36e6e896}

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

2019-11-24 18:55:40 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3d29c0b0}

2019-11-24 18:55:40 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6fdcbb46

2019-11-24 18:55:40 | user :: null >> <iq to="localhost" id="hZWZgP8tgy9lQViBthAv8t1" type="set"><query xmlns="jabber:iq:register"><username>user_gkdxv00028</username><password>user_gkdxv00028</password><email>55b57a55-e66c-4b62-a043-e4c2e5854cc2@localhost</email></query></iq>

2019-11-24 18:55:40 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@295258ff}

2019-11-24 18:55:40 | user :: null << <iq from="localhost" id="hZWZgP8tgy9lQViBthAv8t1" xmlns="jabber:client" type="result"/>

2019-11-24 18:55:40 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@52bd5f92}

2019-11-24 18:55:40 | [Mutex] received everything.

2019-11-24 18:55:40 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 18:55:40 | 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;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39671d6e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3c243637]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1875e81a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1c4a6fcc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5948e221}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5fd99a50}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:40 PST 2019}}}}

2019-11-24 18:55:40 | 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;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39671d6e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3c243637]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1875e81a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1c4a6fcc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5948e221}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5fd99a50}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:40 PST 2019}}}}

2019-11-24 18:55:40 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4fb54e7c

2019-11-24 18:55:40 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@3cea3b7a

2019-11-24 18:55:40 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@36e6a12a

2019-11-24 18:55:40 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@e1f39ab

2019-11-24 18:55:40 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@6bbc50ba

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2drZHh2MDAwMjgscj1kcTZ1ZjlpSm14azAzVGoyeVQwNg==</auth>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kcTZ1ZjlpSm14azAzVGoyeVQwNldnU3d3NUk4NTY2cnE0ZW5odjEwLHM9bmRkYlh4VEx0dkNsTGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZHE2dWY5aUpteGswM1RqMnlUMDZXZ1N3dzVJODU2NnJxNGVuaHYxMCxwPVZNaWY0Nm5KV1JxV1ZmaDZzcFNoSDdGU2lxd2hmU3NZVE1UKzdJVDlpOVU9</response>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1XMUV2K1ZIQzZXYjRzbHMwcEkrVmhkQ0tyYy9JSS9UTjJTRHN3cFBmTTVBPQ==</success>

2019-11-24 18:55:40 | user :: user_gkdxv00028@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 hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="7etRvi08c1DSCAgh81QLOpuANqY="/></features>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <iq xmlns="jabber:client" id="xAHHwfzsgMPGIRV4kM09Atq" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost << <iq id="xAHHwfzsgMPGIRV4kM09Atq" xmlns="jabber:client" to="user_gkdxv00028@localhost/993927746-tigase-20" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_gkdxv00028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="6TAueJuk5nY8oeBuh2hSMBf" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost/993927746-tigase-20 << <iq id="6TAueJuk5nY8oeBuh2hSMBf" xmlns="jabber:client" to="user_gkdxv00028@localhost/993927746-tigase-20" type="result"/>

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

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost/993927746-tigase-20 << <enabled max="60" location="d4270859fb27" resume="true" id="a92e75b1-8924-4237-9c8f-55a5af0ce0c3" xmlns="urn:xmpp:sm:3"/>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost/993927746-tigase-20 >> <iq id="5GT4ueJuk5nY8oeBuh2hSMB" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost/993927746-tigase-20 << <iq id="5GT4ueJuk5nY8oeBuh2hSMB" xmlns="jabber:client" to="user_gkdxv00028@localhost/993927746-tigase-20" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:55:40 | Disconnecting

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

2019-11-24 18:55:40 | [Mutex] notify: [disconnected]

2019-11-24 18:55:40 | [Mutex] received everything.

2019-11-24 18:55:40 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2drZHh2MDAwMjgscj1DWjJWZk54TVJNSDlsNTdvTUE4bw==</auth>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DWjJWZk54TVJNSDlsNTdvTUE4b0JrUnFZb3Fhd3lTc2w1RDAyM2xOLHM9bmRkYlh4VEx0dkNsTGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q1oyVmZOeE1STUg5bDU3b01BOG9Ca1JxWW9xYXd5U3NsNUQwMjNsTixwPXdJTkt1WkY0VG9reDNRRHVxOFdaNEZ0bUlLQktSTXZMS3hlVlMzOVNxbkk9</response>

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

2019-11-24 18:55:40 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:40 | [Mutex] received everything.

2019-11-24 18:55:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:40 | [Mutex] notify: [event, disconnected]

2019-11-24 18:55:40 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2drZHh2MDAwMjgscj15S2tUNE9NeTlLZ21LYmJFU2ExeQ==</auth>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15S2tUNE9NeTlLZ21LYmJFU2ExeUNHa2k3eUxQRDNCaWVRY3k3c3NpLHM9bmRkYlh4VEx0dkNsTGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eUtrVDRPTXk5S2dtS2JiRVNhMXlDR2tpN3lMUEQzQmllUWN5N3NzaSxwPS9CVWFIY2tPTEF4ejVoQnZEVVZqdnRDQ25XSWcydTA5anlYNGNDeXlONUk9</response>

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

2019-11-24 18:55:40 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:40 | [Mutex] received everything.

2019-11-24 18:55:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:40 | [Mutex] notify: [event, disconnected]

2019-11-24 18:55:40 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2drZHh2MDAwMjgscj0yaU84S0V4U3NHelJhV2VYajMxMQ==</auth>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yaU84S0V4U3NHelJhV2VYajMxMVZwNlQ5bVFzOXBUbERVRVpDRWdhLHM9bmRkYlh4VEx0dkNsTGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MmlPOEtFeFNzR3pSYVdlWGozMTFWcDZUOW1RczlwVGxEVUVaQ0VnYSxwPUVVWUo5R1RyT0VJUmJBUU54MXNTK2pQUTc4SUJZUWN6NURYeEMzUTRxS0U9</response>

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

2019-11-24 18:55:40 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:40 | [Mutex] received everything.

2019-11-24 18:55:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:40 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2drZHh2MDAwMjgscj1mZGxicHNaSGQ3eWZPTllwS3diUA==</auth>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mZGxicHNaSGQ3eWZPTllwS3diUFRKRG4zVmRBQjRwZ3I3WUdwTkZDLHM9bmRkYlh4VEx0dkNsTGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZmRsYnBzWkhkN3lmT05ZcEt3YlBUSkRuM1ZkQUI0cGdyN1lHcE5GQyxwPUh6QlhsZVlUV1JiaU5IWnIzakFxZUo2YmdRaGt5RjlLa09jU1YwdU03YVE9</response>

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

2019-11-24 18:55:40 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:40 | [Mutex] received everything.

2019-11-24 18:55:40 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2drZHh2MDAwMjgscj00WlhvVHFncXB6UlN0TElhaWUyYg==</auth>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00WlhvVHFncXB6UlN0TElhaWUyYjdFd08yeGM2eVVXQzZsVEpqeWpXLHM9bmRkYlh4VEx0dkNsTGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:40 | user :: user_gkdxv00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NFpYb1RxZ3FwelJTdExJYWllMmI3RXdPMnhjNnlVV0M2bFRKanlqVyxwPUpjbjRWeXZ2dzNra1hUQW8vYUtMWjNmN1ovY2tJMU9VS3M2eU54OEl3eXM9</response>

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

2019-11-24 18:55:43 | [Mutex] waiting for: [user]

2019-11-24 18:55:43 | [Mutex] received everything.

2019-11-24 18:55:43 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-24 18:55:43 |

2019-11-24 18:55:43 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-24 18:55:43 | ------------------------------------

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@73807ee

2019-11-24 18:55:43 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@9fff979}, 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@dc06c9e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48c2f342}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f029ac3}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:43 PST 2019}}}}

2019-11-24 18:55:43 | [Mutex] waiting for: [registration]

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@79409e6b

2019-11-24 18:55:43 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@9fff979}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@dc06c9e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48c2f342}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f029ac3}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:43 PST 2019}}}}

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@776aa941

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

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

2019-11-24 18:55:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@28ed0c0d}

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

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

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@33225f51

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@4eec2c98

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

2019-11-24 18:55:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6c6ea4a5}

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

2019-11-24 18:55:43 | user :: null >> <iq to="localhost" id="vVwlILEv5ukU5cKV3kQO4hQ" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 18:55:43 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@614dbc0d}

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

2019-11-24 18:55:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2ca35041}

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@d5a4a53

2019-11-24 18:55:43 | user :: null >> <iq to="localhost" id="h74fMRcBw4bpYbODxpQ1ax9" type="set"><query xmlns="jabber:iq:register"><username>user_uhpho30029</username><password>user_uhpho30029</password><email>4b055c75-3c93-434c-8a5e-b473db1ab10b@localhost</email></query></iq>

2019-11-24 18:55:43 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@cbbe1473}

2019-11-24 18:55:43 | user :: null << <iq from="localhost" id="h74fMRcBw4bpYbODxpQ1ax9" xmlns="jabber:client" type="result"/>

2019-11-24 18:55:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@22fd3f8c}

2019-11-24 18:55:43 | [Mutex] received everything.

2019-11-24 18:55:43 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 18:55:43 | 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;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@28ed0c0d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6c6ea4a5]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@9fff979}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@dc06c9e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48c2f342}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f029ac3}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:43 PST 2019}}}}

2019-11-24 18:55:43 | 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;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@28ed0c0d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6c6ea4a5]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@9fff979}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@dc06c9e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48c2f342}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f029ac3}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:43 PST 2019}}}}

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3b2fecfa

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@db89286

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@52ef59b0

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@19a51d3e

2019-11-24 18:55:43 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@5da97acc

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

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VocGhvMzAwMjkscj1HU1FTM09UNkVERm9YVGdIUzJWYQ==</auth>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HU1FTM09UNkVERm9YVGdIUzJWYVU3TEtTM3pZSGRUUmlnVlprd2VGLHM9dGtCMDFwdWdidFZVMnc9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R1NRUzNPVDZFREZvWFRnSFMyVmFVN0xLUzN6WUhkVFJpZ1Zaa3dlRixwPWY1d2taTFpDSjlFYXNkaUxZM0xVQzRqWlI2U3hYRWVIV2JCUDRxeFBQZ3M9</response>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj12b1lJK3M0V0habFI3OFJnZTBiZzlwVlN4KzRiUnc0ZHoxcERXYUsrdElNPQ==</success>

2019-11-24 18:55:43 | user :: user_uhpho30029@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 hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="7etRvi08c1DSCAgh81QLOpuANqY="/></features>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <iq xmlns="jabber:client" id="b2NZbAmQ8p6vubGoPHyl8hP" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost << <iq id="b2NZbAmQ8p6vubGoPHyl8hP" xmlns="jabber:client" to="user_uhpho30029@localhost/993927746-tigase-21" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_uhpho30029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="73OQXWeTZcAi2dIJW5u039s" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost/993927746-tigase-21 << <iq id="73OQXWeTZcAi2dIJW5u039s" xmlns="jabber:client" to="user_uhpho30029@localhost/993927746-tigase-21" type="result"/>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost/993927746-tigase-21 >> <iq to="localhost" id="pLUPORalXfwnSXZiW8x6yxh" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost/993927746-tigase-21 << <enabled max="60" location="d4270859fb27" resume="true" id="721fe5e6-25c4-411d-8b1b-a15716b6f5e8" xmlns="urn:xmpp:sm:3"/>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost/993927746-tigase-21 >> <iq id="aLS4zlU08Izq9MLQItZ8vsV" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost/993927746-tigase-21 << <iq id="aLS4zlU08Izq9MLQItZ8vsV" xmlns="jabber:client" to="user_uhpho30029@localhost/993927746-tigase-21" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:55:43 | Disconnecting

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

2019-11-24 18:55:43 | [Mutex] notify: [disconnected]

2019-11-24 18:55:43 | [Mutex] received everything.

2019-11-24 18:55:43 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3VocGhvMzAwMjkscj1WU1FWVHpJV1pBTmFEUEZ0Mmpkdw==</auth>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WU1FWVHpJV1pBTmFEUEZ0Mmpkd0xzTkxvVFhLYlZhYWhBdWtqNG8wLHM9MzF2bEpEVFRVR29qTFE9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VlNRVlR6SVdaQU5hRFBGdDJqZHdMc05Mb1RYS2JWYWFoQXVrajRvMCxwPVlVVWVyYmgxN2VDeFdCVXdZRmVlZVpRZlgwbz0=</response>

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

2019-11-24 18:55:43 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:43 | [Mutex] notify: [event, disconnected]

2019-11-24 18:55:43 | [Mutex] received everything.

2019-11-24 18:55:43 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:43 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VocGhvMzAwMjkscj15NG9PQnJjSDFkQ1ZycnNXMW5VRg==</auth>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15NG9PQnJjSDFkQ1ZycnNXMW5VRmRMcnlxUk5IZFRpc0ZUa0VYS09rLHM9dGtCMDFwdWdidFZVMnc9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eTRvT0JyY0gxZENWcnJzVzFuVUZkTHJ5cVJOSGRUaXNGVGtFWEtPayxwPVR2Q1QxekZZeDh5MWt1c2VjaFhJbXV4VmU4bkM3OERZUi9GbmlMUG4yL0U9</response>

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

2019-11-24 18:55:43 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:43 | [Mutex] received everything.

2019-11-24 18:55:43 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:43 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3VocGhvMzAwMjkscj12NjN6TmlLeFliVlRVdFI5VDlTbg==</auth>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12NjN6TmlLeFliVlRVdFI5VDlTbnRCOTdHOW9ucndpY0NIVTg2STJhLHM9MzF2bEpEVFRVR29qTFE9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9djYzek5pS3hZYlZUVXRSOVQ5U250Qjk3RzlvbnJ3aWNDSFU4NkkyYSxwPU4wNUltN1NlZS9KMWU2aGJ6cFI5NERkMWZnMD0=</response>

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

2019-11-24 18:55:43 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:43 | [Mutex] received everything.

2019-11-24 18:55:43 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:43 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:43 | user :: user_uhpho30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:44 | user :: user_uhpho30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfdWhwaG8zMDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-24 18:55:44 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:44 | [Mutex] received everything.

2019-11-24 18:55:44 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-24 18:55:44 | user :: user_uhpho30029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:44 | user :: user_uhpho30029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VocGhvMzAwMjkscj0yREI3dE10YnlySGoyQkptRnp2Yg==</auth>

2019-11-24 18:55:44 | user :: user_uhpho30029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yREI3dE10YnlySGoyQkptRnp2YmRITzB4bzJkdUkwdFVoVHhHTUlRLHM9dGtCMDFwdWdidFZVMnc9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:44 | user :: user_uhpho30029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MkRCN3RNdGJ5ckhqMkJKbUZ6dmJkSE8weG8yZHVJMHRVaFR4R01JUSxwPU9PZTY3QnBBb0NhU2s3SDRoR3RheGZWZ3liZmJrZElEUlZwZXduS1ozcWc9</response>

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

2019-11-24 18:55:46 | [Mutex] waiting for: [user]

2019-11-24 18:55:46 | [Mutex] received everything.

2019-11-24 18:55:46 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-24 18:55:46 |

2019-11-24 18:55:46 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-24 18:55:46 | ------------------------------------

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2f15bbce

2019-11-24 18:55:46 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@21d2405c}, 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@25edd0be}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@60ef4a67}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@62a6567f}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:46 PST 2019}}}}

2019-11-24 18:55:46 | [Mutex] waiting for: [registration]

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@51452ad7

2019-11-24 18:55:46 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@21d2405c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@25edd0be}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@60ef4a67}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@62a6567f}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:46 PST 2019}}}}

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@1ae66861

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

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

2019-11-24 18:55:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c0b528}

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

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

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@50850ee1

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@28ee85b4

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

2019-11-24 18:55:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1e245a8}

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

2019-11-24 18:55:46 | user :: null >> <iq to="localhost" id="b8TbzmUWkNS3An4anNKJUPV" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 18:55:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e4b70542}

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

2019-11-24 18:55:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@48ec949}

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@7c042d3f

2019-11-24 18:55:46 | user :: null >> <iq to="localhost" id="A0tZiW8x6yxhMKCGviTgJMA" type="set"><query xmlns="jabber:iq:register"><username>user_5yf4fd0030</username><password>user_5yf4fd0030</password><email>4e5146d2-7e8c-46e4-a4d8-4171a27984fe@localhost</email></query></iq>

2019-11-24 18:55:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1bf5915}

2019-11-24 18:55:46 | user :: null << <iq from="localhost" id="A0tZiW8x6yxhMKCGviTgJMA" xmlns="jabber:client" type="result"/>

2019-11-24 18:55:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@209bd42e}

2019-11-24 18:55:46 | [Mutex] received everything.

2019-11-24 18:55:46 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 18:55:46 | 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;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c0b528, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1e245a8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@21d2405c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@25edd0be}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@60ef4a67}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@62a6567f}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:46 PST 2019}}}}

2019-11-24 18:55:46 | 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;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c0b528, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1e245a8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@21d2405c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@25edd0be}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@60ef4a67}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@62a6567f}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:55:46 PST 2019}}}}

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@33c70a90

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@41f14920

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1c41e9f4

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@620574f6

2019-11-24 18:55:46 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@699d61ac

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

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV5ZjRmZDAwMzAscj1oQ00xcTBveHRERGJCZnlxQXI2NQ==</auth>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oQ00xcTBveHRERGJCZnlxQXI2NUZ2TGhERm1WYjBvUVVSVElzTzBVLHM9aU53UzR6YzIyU1lSM3c9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aENNMXEwb3h0RERiQmZ5cUFyNjVGdkxoREZtVmIwb1FVUlRJc08wVSxwPXh1Y2hiMFBrQUNBQ1lNTHR6b2ZyOE9zc05QQzgrdTZPYnZKQU91bEhobU09</response>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1CV01XWDh4S1liUEtBMjlNSW01WE9FNHJDcGR1Z2Fkb0F5Y3pBWmR2aXhnPQ==</success>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@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 hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="7etRvi08c1DSCAgh81QLOpuANqY="/></features>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <iq xmlns="jabber:client" id="qR08vsV7zaFs7jWeIHqcPRW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost << <iq id="qR08vsV7zaFs7jWeIHqcPRW" xmlns="jabber:client" to="user_5yf4fd0030@localhost/993927746-tigase-22" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_5yf4fd0030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="F6Ho8HBq2cQPWbQT6ev3gLY" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost/993927746-tigase-22 << <iq id="F6Ho8HBq2cQPWbQT6ev3gLY" xmlns="jabber:client" to="user_5yf4fd0030@localhost/993927746-tigase-22" type="result"/>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="qT2cDIr9DiVY9n4ueJuk5nY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost/993927746-tigase-22 << <enabled max="60" location="d4270859fb27" resume="true" id="703dc368-5d05-41db-a83a-050e099025df" xmlns="urn:xmpp:sm:3"/>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost/993927746-tigase-22 >> <iq id="UT015kTetdLyr0dvk0gNCAB" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost/993927746-tigase-22 << <iq id="UT015kTetdLyr0dvk0gNCAB" xmlns="jabber:client" to="user_5yf4fd0030@localhost/993927746-tigase-22" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:55:46 | Disconnecting

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

2019-11-24 18:55:46 | [Mutex] notify: [disconnected]

2019-11-24 18:55:46 | [Mutex] received everything.

2019-11-24 18:55:46 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV5ZjRmZDAwMzAscj1PNktRbjdXZm92V01YVGJwbHdaeQ==</auth>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PNktRbjdXZm92V01YVGJwbHdaeUl0NElTVjVRVFAzdUwxZFVDcU5yLHM9aU53UzR6YzIyU1lSM3c9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TzZLUW43V2ZvdldNWFRicGx3WnlJdDRJU1Y1UVRQM3VMMWRVQ3FOcixwPVoyN0dydDVoMXlEUDhLRlYxbU9BMFpHeVBwdS9xcGcyalBjd05NM09XUUk9</response>

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

2019-11-24 18:55:46 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:46 | [Mutex] received everything.

2019-11-24 18:55:46 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:46 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV5ZjRmZDAwMzAscj1wQ1Zld0JDc25vSmt6QTA0bWNxcw==</auth>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wQ1Zld0JDc25vSmt6QTA0bWNxc1kwS05LYXZ4aTZac3ZWMHdzT3poLHM9aU53UzR6YzIyU1lSM3c9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cENWZXdCQ3Nub0prekEwNG1jcXNZMEtOS2F2eGk2WnN2VjB3c096aCxwPTB4Y0VOSmk3OSszYUJIdi8rTFFDcFZleG1HRTVFVllaSldMUVVoNlJVK3c9</response>

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

2019-11-24 18:55:46 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:46 | [Mutex] received everything.

2019-11-24 18:55:46 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:55:46 | [Mutex] waiting for: [event]

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

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV5ZjRmZDAwMzAscj1ucVZiTlpxRldvUlBxWG9vZjc5SQ==</auth>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ucVZiTlpxRldvUlBxWG9vZjc5SUd0OGFjY1R4WFJhOGZTak42RmtNLHM9aU53UzR6YzIyU1lSM3c9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:46 | user :: user_5yf4fd0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bnFWYk5acUZXb1JQcVhvb2Y3OUlHdDhhY2NUeFhSYThmU2pONkZrTSxwPWVQSktyS0lrVEFzVFJ2d2hkMFhEYUVyb2dxRTgreHZ6RmpCYld0cUFCUEE9</response>

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

2019-11-24 18:55:46 | [Mutex] notify: [event, authFailed]

2019-11-24 18:55:46 | [Mutex] received everything.

2019-11-24 18:55:46 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV5ZjRmZDAwMzAscj04NlhpamRoZHpTNFcwMDE0Z3ZWWg==</auth>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04NlhpamRoZHpTNFcwMDE0Z3ZWWk4wdmpZTmhMNzh0QUJrR1dpOTRELHM9aU53UzR6YzIyU1lSM3c9PSxpPTQwOTY=</challenge>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ODZYaWpkaGR6UzRXMDAxNGd2VlpOMHZqWU5oTDc4dEFCa0dXaTk0RCxwPWUxQlhpVGo5eE1XYU1xZ05RYXZJTlRkZDVOVlRUanhlMnhETlVwWGFDcEU9</response>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1jbWdRcU1oa2tZeUY3QmEzVVdwbDhUUFozYkJ6ZVRmSFNkM3h1OFlJV25JPQ==</success>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@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 hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="7etRvi08c1DSCAgh81QLOpuANqY="/></features>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost >> <iq xmlns="jabber:client" id="Zkhxl14t4lLQ2kVS6DtawaM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost << <iq id="Zkhxl14t4lLQ2kVS6DtawaM" xmlns="jabber:client" to="user_5yf4fd0030@localhost/993927746-tigase-23" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_5yf4fd0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="2eX0dvk0gNCABp2gEKDypiN" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost/993927746-tigase-23 << <iq id="2eX0dvk0gNCABp2gEKDypiN" xmlns="jabber:client" to="user_5yf4fd0030@localhost/993927746-tigase-23" type="result"/>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="m7AsWVTW7Gn1nMTU17ysaBe" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost/993927746-tigase-23 << <enabled max="60" location="d4270859fb27" resume="true" id="a2181a29-7427-4ec3-94c7-3634fda0000e" xmlns="urn:xmpp:sm:3"/>

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost/993927746-tigase-23 >> <iq id="i4p4rmVamLziP6dHJujKHtg" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-24 18:55:47 | user :: user_5yf4fd0030@localhost/993927746-tigase-23 << <iq id="i4p4rmVamLziP6dHJujKHtg" xmlns="jabber:client" to="user_5yf4fd0030@localhost/993927746-tigase-23" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:55:47 | Disconnecting

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

2019-11-24 18:55:47 | [Mutex] notify: [disconnected]

2019-11-24 18:55:47 | [Mutex] received everything.

2019-11-24 18:55:49 | [Mutex] waiting for: [user]

2019-11-24 18:55:49 | [Mutex] received everything.

2019-11-24 18:55:49 | [Mutex] isItemNotified: user:ok:true :: true