Brute Force Prevention

Test duration: 15.082s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.503s
2019-10-13 19:25:10 |

2019-10-13 19:25:10 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 19:25:10 | ------------------------------------

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@330f9f0

2019-10-13 19:25:10 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@df717e6}, 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@9c89280}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4cca1ddd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@483192cd}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:10 PDT 2019}}}}

2019-10-13 19:25:10 | [Mutex] waiting for: [registration]

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7dccf40a

2019-10-13 19:25:10 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@df717e6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@9c89280}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4cca1ddd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@483192cd}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:10 PDT 2019}}}}

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@30dd25a1

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

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

2019-10-13 19:25:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2ce5e292}

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

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

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6886aa39

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@72706f87

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

2019-10-13 19:25:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2bd9ac45}

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

2019-10-13 19:25:10 | user :: null >> <iq to="localhost" id="6NbmUZcHJTWSXbq5qRQ9u5k" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 19:25:10 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e748cfc7}

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

2019-10-13 19:25:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@28ab3ade}

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@75218a90

2019-10-13 19:25:10 | user :: null >> <iq to="localhost" id="3YGMFv1eDuhTdAaxlKJIr0t" type="set"><query xmlns="jabber:iq:register"><username>user_mh2g1y0019</username><password>user_mh2g1y0019</password><email>1f2ba2ec-df39-464b-b3da-8a155424a8a6@localhost</email></query></iq>

2019-10-13 19:25:10 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b256cc43}

2019-10-13 19:25:10 | [Mutex] received everything.

2019-10-13 19:25:10 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 19:25:10 | user :: null << <iq xmlns="jabber:client" id="3YGMFv1eDuhTdAaxlKJIr0t" type="result" from="localhost"/>

2019-10-13 19:25:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@45cdfe4}

2019-10-13 19:25:10 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2ce5e292, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2bd9ac45]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@df717e6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@9c89280}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4cca1ddd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@483192cd}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:10 PDT 2019}}}}

2019-10-13 19:25:10 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2ce5e292, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2bd9ac45]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@df717e6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@9c89280}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4cca1ddd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@483192cd}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:10 PDT 2019}}}}

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6281e0ae

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@138d5bea

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6a812601

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@8c0774a

2019-10-13 19:25:10 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6529726c

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

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1ybkFQaTVVRXFveDAyRElRNkE4Yg==</auth>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ybkFQaTVVRXFveDAyRElRNkE4YmVZOHdydGQ1WFYyMmt1eGwzWTdGLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cm5BUGk1VUVxb3gwMkRJUTZBOGJlWTh3cnRkNVhWMjJrdXhsM1k3RixwPWNZTTZTcXFWdXpHbWRaUTBVTmc0dnlSdzdyci8zV1ZQU1dob0g5S0REOUU9</response>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1hZUcxcFhWOUd5blZEcGYxOEVzVExOTXpTWGJ5YlluSlc4dXdlUzNmUnF3PQ==</success>

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

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <iq xmlns="jabber:client" id="hVv3lWTUhKBm1mKVViIILX1" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost << <iq to="user_mh2g1y0019@localhost/993927746-tigase-13" id="hVv3lWTUhKBm1mKVViIILX1" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_mh2g1y0019@localhost/993927746-tigase-13</jid></bind></iq>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost/993927746-tigase-13 >> <iq xmlns="jabber:client" id="KPblT3azoNITY3gPYYnP6kW" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost/993927746-tigase-13 << <iq to="user_mh2g1y0019@localhost/993927746-tigase-13" id="KPblT3azoNITY3gPYYnP6kW" type="result" xmlns="jabber:client"/>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost/993927746-tigase-13 >> <iq to="localhost" id="lHLDJEpYfOEJxwaCzzfFlSV" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost/993927746-tigase-13 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost/993927746-tigase-13 << <enabled id="c4351348-6d70-40c6-b8e3-84cbd438836f" resume="true" location="d4270859fb27" max="60" xmlns="urn:xmpp:sm:3"/>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost/993927746-tigase-13 >> <iq id="7IMJDuhTdAaxlKJIr0t8nU7" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost/993927746-tigase-13 << <iq xmlns="jabber:client" to="user_mh2g1y0019@localhost/993927746-tigase-13" id="lHLDJEpYfOEJxwaCzzfFlSV" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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 category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost/993927746-tigase-13 << <iq to="user_mh2g1y0019@localhost/993927746-tigase-13" id="7IMJDuhTdAaxlKJIr0t8nU7" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:25:10 | Disconnecting

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

2019-10-13 19:25:10 | [Mutex] notify: [disconnected]

2019-10-13 19:25:10 | [Mutex] received everything.

2019-10-13 19:25:10 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj11Z0FRa1NSRnZ1Q0VLN0pvOEZDZg==</auth>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11Z0FRa1NSRnZ1Q0VLN0pvOEZDZk9qZTY2Q2ptS2NUR2FVZWFDV0Z0LHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWdBUWtTUkZ2dUNFSzdKbzhGQ2ZPamU2NkNqbUtjVEdhVWVhQ1dGdCxwPStVajhDL1ZvZVY4OEdJU29ucUd1L3lqWjF3UnV5d3J3WERRRk5ZemZRQTQ9</response>

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

2019-10-13 19:25:10 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:10 | [Mutex] received everything.

2019-10-13 19:25:10 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:10 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1tWkhCdlo2aUJhVWxPMmZPNHVVQQ==</auth>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tWkhCdlo2aUJhVWxPMmZPNHVVQVdSeEZNaUlrYlFEcWJkaXZvVHZZLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bVpIQnZaNmlCYVVsTzJmTzR1VUFXUnhGTWlJa2JRRHFiZGl2b1R2WSxwPWd1V0g2SFozQWE0OGoyK2c1L3ZwNzlBRElxeGpoZGtVNEh2YjN4N3JjOU09</response>

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

2019-10-13 19:25:10 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:10 | [Mutex] received everything.

2019-10-13 19:25:10 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:10 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:10 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1kemEzam5DMmhRaWc0N0RQTUxGVg==</auth>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kemEzam5DMmhRaWc0N0RQTUxGVm9YVWZYWm9UMUU2a2NaYkJZZlZCLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZHphM2puQzJoUWlnNDdEUE1MRlZvWFVmWFpvVDFFNmtjWmJCWWZWQixwPUM4WTAzY2dSUFJDaFVKQ2pzMlE2TlVtTlYxWnllNW1hek16NGZNQjNTekU9</response>

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

2019-10-13 19:25:11 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:11 | [Mutex] received everything.

2019-10-13 19:25:11 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:11 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1uV0E5dXpiemR1MXZyN0hGUjdkTw==</auth>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uV0E5dXpiemR1MXZyN0hGUjdkT0hDcmF4SGVoRWp4QmwxTnpob1U0LHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bldBOXV6YnpkdTF2cjdIRlI3ZE9IQ3JheEhlaEVqeEJsMU56aG9VNCxwPUNvNjRyRTFUYzF1R0RjcUc5bCtrZCtxR3Nsc0xMdmE0S0Qxd1E2c3hKUkU9</response>

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

2019-10-13 19:25:11 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:11 | [Mutex] received everything.

2019-10-13 19:25:11 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:11 | [Mutex] notify: [event, disconnected]

2019-10-13 19:25:11 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1BczhGOXhUSFVOSlpjV0w2TTc4Tg==</auth>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BczhGOXhUSFVOSlpjV0w2TTc4TnlrQjh5QWhTWFU5SUNWMEUyV3RvLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QXM4Rjl4VEhVTkpaY1dMNk03OE55a0I4eUFoU1hVOUlDVjBFMld0byxwPU5Tcmt0dW4wRk94VnB2NWloRFVsY3ZVUkhrT1pKVmtGdmpTaGdqd3hjTjA9</response>

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

2019-10-13 19:25:11 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:11 | [Mutex] received everything.

2019-10-13 19:25:11 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:11 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1tZFRWdkgweXM3SXF1b2t0Y25zWQ==</auth>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tZFRWdkgweXM3SXF1b2t0Y25zWUViVnFlMkViS014dXlIWXZqYUs5LHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bWRUVnZIMHlzN0lxdW9rdGNuc1lFYlZxZTJFYktNeHV5SFl2amFLOSxwPTg2QzNDdUJLSkc4QnF2dWZKOXczOG1UWTZkNWltNlgwYXhjVy9randHdU09</response>

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

2019-10-13 19:25:11 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:11 | [Mutex] received everything.

2019-10-13 19:25:11 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:11 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1wVmRFbTlRZ1phWkF0RjVlRllTUg==</auth>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wVmRFbTlRZ1phWkF0RjVlRllTUjZuSUJVbkM0QWR6a2RLVjdUYkQyLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cFZkRW05UWdaYVpBdEY1ZUZZU1I2bklCVW5DNEFkemtkS1Y3VGJEMixwPWZ5eEtDQTBmS3FMR1JOb0lNamUrcGJ5SlZsQ2pucVlGNFBjWHE0ajR4WDA9</response>

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

2019-10-13 19:25:11 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:11 | [Mutex] received everything.

2019-10-13 19:25:11 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:11 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj10NmhqQmxmZWdNdFQ2ZWZsZENLeA==</auth>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10NmhqQmxmZWdNdFQ2ZWZsZENLeElLaXFXNXQ5SHkxSXZjYXduUDJELHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dDZoakJsZmVnTXRUNmVmbGRDS3hJS2lxVzV0OUh5MUl2Y2F3blAyRCxwPVBqenVvaHdYZm5qVWViMGVzd0VFbkZiL0xUL0VUMVpFcWRXbU1NT1ZNZW89</response>

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

2019-10-13 19:25:11 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:11 | [Mutex] received everything.

2019-10-13 19:25:11 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:11 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1vcHBjRWtWZFJqQUt3bG8yVDZKRw==</auth>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vcHBjRWtWZFJqQUt3bG8yVDZKR05yMkNsUThkcTVqVGFFdnQ4MHJtLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b3BwY0VrVmRSakFLd2xvMlQ2SkdOcjJDbFE4ZHE1alRhRXZ0ODBybSxwPXlBam16QnJBKzUzV0RERTQ0aUZhL2o1eUU5ZUR4bjhMVUdlTTZKSXJSQkU9</response>

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

2019-10-13 19:25:11 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:11 | [Mutex] received everything.

2019-10-13 19:25:11 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:11 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1nZFhjTENIbXlYd0Y1OU85SlpXWQ==</auth>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nZFhjTENIbXlYd0Y1OU85SlpXWXE4V1FiY1ZRTkdha2ZQYUwydmFqLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z2RYY0xDSG15WHdGNTlPOUpaV1lxOFdRYmNWUU5HYWtmUGFMMnZhaixwPUh3QlJlVjlYcnpzaGlTNVVxZEtXVDJWUE03NGlkcFFRdGoyRnNJM3ZVRFk9</response>

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

2019-10-13 19:25:11 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:11 | [Mutex] received everything.

2019-10-13 19:25:11 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:11 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:11 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1NQ1ZTb2ttcTBMOHhpWjdPOTRWUA==</auth>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NQ1ZTb2ttcTBMOHhpWjdPOTRWUFZ6OThSQUQ3bnVlWjFBMU1RZnhHLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TUNWU29rbXEwTDh4aVo3Tzk0VlBWejk4UkFEN251ZVoxQTFNUWZ4RyxwPWsvOStkS3pHUlFBTUR1UXA0anA1RHhHQmM2MFAwN0R4eWtSQi9kSmcvUjA9</response>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 19:25:12 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:12 | [Mutex] notify: [event, disconnected]

2019-10-13 19:25:12 | [Mutex] received everything.

2019-10-13 19:25:12 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:12 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj12bUs4NVEwWGEwdVdzWTBHUThqOA==</auth>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12bUs4NVEwWGEwdVdzWTBHUThqOERCdzV6Q0NMM3k3dm5yT3JFUXpvLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dm1LODVRMFhhMHVXc1kwR1E4ajhEQnc1ekNDTDN5N3Zuck9yRVF6byxwPStoTWdFR2NIYlk0RTl4VjNtOWJKV0pvWHh2QU16UkFQQ1grTTV0Ri9Ua0E9</response>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 19:25:12 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:12 | [Mutex] received everything.

2019-10-13 19:25:12 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:12 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj11clJQb293RWRXRG1HbEhSMGNNTQ==</auth>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11clJQb293RWRXRG1HbEhSMGNNTXdaVkN2Y0tONUxzZ2xZY3RxeEk5LHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dXJSUG9vd0VkV0RtR2xIUjBjTU13WlZDdmNLTjVMc2dsWWN0cXhJOSxwPWZ1RU9xeEdRcXo3eG5UVXp2aWxIektCWm1EWVpCeE1WZEhsZms5M1RlclU9</response>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 19:25:12 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:12 | [Mutex] received everything.

2019-10-13 19:25:12 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:12 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj11YjZmbW80OE55RXBJZ0Y5TmZvMA==</auth>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11YjZmbW80OE55RXBJZ0Y5TmZvMGtucVlsc0NLQ0FCUnBoTVBQZFd3LHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWI2Zm1vNDhOeUVwSWdGOU5mbzBrbnFZbHNDS0NBQlJwaE1QUGRXdyxwPUhwYXVPYjNWY0dWakovNXFNcjcxV3B3Z2ZBN2dFcEUycWF4RVNVQm1jRjg9</response>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 19:25:12 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:12 | [Mutex] received everything.

2019-10-13 19:25:12 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:12 | [Mutex] notify: [event, disconnected]

2019-10-13 19:25:12 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1jOGpBTFhGRENqM3ZTYTVvVm5vTw==</auth>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jOGpBTFhGRENqM3ZTYTVvVm5vT1RsQkpTMkhuVTZHRkRYc1k5cHRKLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YzhqQUxYRkRDajN2U2E1b1Zub09UbEJKUzJIblU2R0ZEWHNZOXB0SixwPWVYd2lreFlZM0hVQ3hnemU4ZWNKQnNYK0lTbC9JSklhT0IwWS81ejRja1E9</response>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 19:25:12 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:12 | [Mutex] received everything.

2019-10-13 19:25:12 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:12 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1WYkFPVDNud1pUTHo4ank4QXMwVg==</auth>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WYkFPVDNud1pUTHo4ank4QXMwVkRtaWtHWEJ3VlE2UXg0WU5udEoyLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VmJBT1QzbndaVEx6OGp5OEFzMFZEbWlrR1hCd1ZRNlF4NFlObnRKMixwPS9GWHhsUDBoQmh5YngvaEJFdThKTDFhejJUa2Zza1RUanIvdm1MYi9xK0E9</response>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 19:25:12 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:12 | [Mutex] received everything.

2019-10-13 19:25:12 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:12 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1KVnBEand2QmFUcEY4TXNnNjd3UQ==</auth>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KVnBEand2QmFUcEY4TXNnNjd3UVVQOXh0dm5YaE1JQTgxUU5xdG40LHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SlZwRGp3dkJhVHBGOE1zZzY3d1FVUDl4dHZuWGhNSUE4MVFOcXRuNCxwPVJPRlowQVJCcStTVkErYVI2bmxXekpUcWhMZ1ZFVmxYa2VJVmFiRWZSaE09</response>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 19:25:12 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:12 | [Mutex] received everything.

2019-10-13 19:25:12 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:12 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1QazJpUkZzendOSHlJeVA0ZUpRVg==</auth>

2019-10-13 19:25:12 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QazJpUkZzendOSHlJeVA0ZUpRVm9VR0JtNmt3cEFhWkdxd251UU00LHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UGsyaVJGc3p3Tkh5SXlQNGVKUVZvVUdCbTZrd3BBYVpHcXdudVFNNCxwPU4xc0dCVkJqeDJGZi85NVdVMVRCbWZ2OVVEajlPUXlleWoyNDgzTmZQMTg9</response>

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

2019-10-13 19:25:13 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:13 | [Mutex] received everything.

2019-10-13 19:25:13 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:13 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1mWmtzWmhqOFcyc2JHRFJhaHVkRw==</auth>

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mWmtzWmhqOFcyc2JHRFJhaHVkR0NZUmJyVVJDOGxNTFFibXVhdW93LHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Zlprc1poajhXMnNiR0RSYWh1ZEdDWVJiclVSQzhsTUxRYm11YXVvdyxwPThkTEs2ZUtSWEcrWHNUWlFETGRrSmJ3TEp1Vmg5RFlERklCdUJQS1dxSlE9</response>

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

2019-10-13 19:25:13 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:13 | [Mutex] received everything.

2019-10-13 19:25:13 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:13 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1OQnhINmpoY0V6RXBoTWRhMkRobw==</auth>

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OQnhINmpoY0V6RXBoTWRhMkRobzZJUEE4QVl4d0tsVG5lS0d4eUhpLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TkJ4SDZqaGNFekVwaE1kYTJEaG82SVBBOEFZeHdLbFRuZUtHeHlIaSxwPWNheW16OGVCL1F6bS9SRkpxaFlGTDNWSVNuSG5EOFBsK2Z5N1hma0JhT2M9</response>

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

2019-10-13 19:25:13 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:13 | [Mutex] notify: [event, disconnected]

2019-10-13 19:25:13 | [Mutex] received everything.

2019-10-13 19:25:13 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:13 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj1iaUtnMzlVaExxS3JYYVlGdnJZcw==</auth>

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iaUtnMzlVaExxS3JYYVlGdnJZc01PMzJOMFhOVk1OcHR4bkhQQWZTLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YmlLZzM5VWhMcUtyWGFZRnZyWXNNTzMyTjBYTlZNTnB0eG5IUEFmUyxwPTQwVm1DRVR6QU9uSU4rSG90Nkx1Z0YxcmRuRmxtbGFyQ1ptaEg3UnBjdnM9</response>

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

2019-10-13 19:25:13 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:13 | [Mutex] received everything.

2019-10-13 19:25:13 | [Mutex] isItemNotified: authFailed :: true

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

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX21oMmcxeTAwMTkscj14OEtMdU9LV3k5UDJ4bUNRQVBrNQ==</auth>

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14OEtMdU9LV3k5UDJ4bUNRQVBrNThpQnFWT2pyUVgwQzB0ZXJ0Q2dkLHM9L2dKRGwwUnZBSVZvRGc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:13 | user :: user_mh2g1y0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eDhLTHVPS1d5OVAyeG1DUUFQazU4aUJxVk9qclFYMEMwdGVydENnZCxwPXE4WmNveVNvcUZRbUtscDRPK2RhYXFFZmJnTnJlSjFNaURLbEptTWY1dFk9</response>

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

2019-10-13 19:25:15 | [Mutex] waiting for: [user]

2019-10-13 19:25:15 | [Mutex] received everything.

2019-10-13 19:25:15 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.243s
2019-10-13 19:25:15 |

2019-10-13 19:25:15 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 19:25:15 | ------------------------------------

2019-10-13 19:25:15 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@8f65e8a

2019-10-13 19:25:15 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@631a1e4}, 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@20e35fa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@470cabdf}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7db4bfba}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:15 PDT 2019}}}}

2019-10-13 19:25:15 | [Mutex] waiting for: [registration]

2019-10-13 19:25:15 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@76810f69

2019-10-13 19:25:15 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@631a1e4}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@20e35fa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@470cabdf}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7db4bfba}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:15 PDT 2019}}}}

2019-10-13 19:25:15 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@5d345a6

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

2019-10-13 19:25:15 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@27235490}

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

2019-10-13 19:25:15 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:25:15 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 19:25:15 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@7fb276a1

2019-10-13 19:25:15 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@136d479

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

2019-10-13 19:25:15 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ed74f8c}

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

2019-10-13 19:25:15 | user :: null >> <iq to="localhost" id="RLPLZar2n4aLBEq8BDnVRUZ" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 19:25:15 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@50bc8dd3}

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

2019-10-13 19:25:15 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@236d0f12}

2019-10-13 19:25:15 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@4f0662a0

2019-10-13 19:25:15 | user :: null >> <iq to="localhost" id="7MQRT0jXlQGzpSZet4BoTWb" type="set"><query xmlns="jabber:iq:register"><username>user_sxwloz0020</username><password>user_sxwloz0020</password><email>3cdb2a99-1f8c-4e48-926d-ab7089d095fb@localhost</email></query></iq>

2019-10-13 19:25:15 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@437a4467}

2019-10-13 19:25:16 | user :: null << <iq xmlns="jabber:client" id="7MQRT0jXlQGzpSZet4BoTWb" type="result" from="localhost"/>

2019-10-13 19:25:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@78a4f225}

2019-10-13 19:25:16 | [Mutex] received everything.

2019-10-13 19:25:16 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 19:25:16 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@27235490, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ed74f8c]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@631a1e4}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@20e35fa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@470cabdf}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7db4bfba}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:16 PDT 2019}}}}

2019-10-13 19:25:16 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@27235490, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ed74f8c]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@631a1e4}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@20e35fa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@470cabdf}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7db4bfba}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:16 PDT 2019}}}}

2019-10-13 19:25:16 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5c2b6992

2019-10-13 19:25:16 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@17f5f89a

2019-10-13 19:25:16 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6b1a8ba6

2019-10-13 19:25:16 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@34f0793a

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:25:16 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3310e1cf

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3N4d2xvejAwMjAscj1lSHI1ZElGMjdlamJxZnhyZFZlTQ==</auth>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lSHI1ZElGMjdlamJxZnhyZFZlTXhUeFhKdG1NVUNqdVM5ZHhZSTRnLHM9NXRORWQxbmpjNWRlT2c9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZUhyNWRJRjI3ZWpicWZ4cmRWZU14VHhYSnRtTVVDanVTOWR4WUk0ZyxwPXpLZnl3QytjUVNRMWhFejM4cU5DUTZ4MURLWVNLaW1WcTQwZWRGbGlVazA9</response>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1lSjRUeUFTMVM5ZDdPTkVpOG1UV1MyV0xJNXRpQzhUcUUyWi9HRTRRK0ZrPQ==</success>

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <iq xmlns="jabber:client" id="nfdBjMR26Dl8o4tnRTNMJGF" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost << <iq to="user_sxwloz0020@localhost/993927746-tigase-14" id="nfdBjMR26Dl8o4tnRTNMJGF" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_sxwloz0020@localhost/993927746-tigase-14</jid></bind></iq>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost/993927746-tigase-14 >> <iq xmlns="jabber:client" id="c8Q6mIDx8vgxcRUV0jWUfzA" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost/993927746-tigase-14 << <iq to="user_sxwloz0020@localhost/993927746-tigase-14" id="c8Q6mIDx8vgxcRUV0jWUfzA" type="result" xmlns="jabber:client"/>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost/993927746-tigase-14 >> <iq to="localhost" id="b7LQ7oMLNExkFsnWZ8zsWjH" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost/993927746-tigase-14 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost/993927746-tigase-14 >> <iq id="o1rY6vkGNFMGEDHvbnW3kXf" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost/993927746-tigase-14 << <enabled id="4ebaf4d6-231f-4e7c-96ec-95e488cbc54c" resume="true" location="d4270859fb27" max="60" xmlns="urn:xmpp:sm:3"/>

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost/993927746-tigase-14 << <iq xmlns="jabber:client" to="user_sxwloz0020@localhost/993927746-tigase-14" id="b7LQ7oMLNExkFsnWZ8zsWjH" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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 category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost/993927746-tigase-14 << <iq to="user_sxwloz0020@localhost/993927746-tigase-14" id="o1rY6vkGNFMGEDHvbnW3kXf" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:25:16 | Disconnecting

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

2019-10-13 19:25:16 | [Mutex] notify: [disconnected]

2019-10-13 19:25:16 | [Mutex] received everything.

2019-10-13 19:25:16 | [Mutex] waiting for: [event]

2019-10-13 19:25:16 | [Mutex] notify: [disconnected]

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3N4d2xvejAwMjAscj1aakwyR0R6SjRNVXRzQUhQTmhQeA==</auth>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aakwyR0R6SjRNVXRzQUhQTmhQeG95VU5TaUpJeGpLbkpmZ0lKSGFiLHM9NXRORWQxbmpjNWRlT2c9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WmpMMkdEeko0TVV0c0FIUE5oUHhveVVOU2lKSXhqS25KZmdJSkhhYixwPW1kcGpoRTVLeHk3WnhIWG1OREcrTTRIaXhYdDhZTzZBMnl5RjFoU3pZU2s9</response>

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

2019-10-13 19:25:16 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:16 | [Mutex] received everything.

2019-10-13 19:25:16 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:16 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3N4d2xvejAwMjAscj0xTGdNdUhLdlcxNEl5eHpEUXF1dA==</auth>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xTGdNdUhLdlcxNEl5eHpEUXF1dE5CU280NExiVzRTY25wdWM4UWxnLHM9NXRORWQxbmpjNWRlT2c9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MUxnTXVIS3ZXMTRJeXh6RFFxdXROQlNvNDRMYlc0U2NucHVjOFFsZyxwPTl4cVczVlBwQVE0WjNHa0t0aTNSMnV6QTJGR3lndUR6cW5Sakd5NnpndTA9</response>

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

2019-10-13 19:25:16 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:16 | [Mutex] received everything.

2019-10-13 19:25:16 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:16 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3N4d2xvejAwMjAscj1uNUc5WjNJTWJzVVR0MEoydXVzVQ==</auth>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uNUc5WjNJTWJzVVR0MEoydXVzVWRVbzJEd2czMVlIUlJiYkkxNTluLHM9NXRORWQxbmpjNWRlT2c9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bjVHOVozSU1ic1VUdDBKMnV1c1VkVW8yRHdnMzFZSFJSYmJJMTU5bixwPVVmdkxKa0g5NktNQTJLcUlkck56RlBUU1g0TnB2ODY1ZDhvd2JsT0NndEk9</response>

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

2019-10-13 19:25:16 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:16 | [Mutex] received everything.

2019-10-13 19:25:16 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:16 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3N4d2xvejAwMjAscj00YXE2NHVJRHdVQ050b1Q0ek9VaQ==</auth>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00YXE2NHVJRHdVQ050b1Q0ek9VaTVvRmk0bUhuV0tlOExpN0xCQ0pMLHM9NXRORWQxbmpjNWRlT2c9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NGFxNjR1SUR3VUNOdG9UNHpPVWk1b0ZpNG1IbldLZThMaTdMQkNKTCxwPWZoNWV3SVR2YmNJRkRXb1VYZml2YU5udHh2WDZoNm1wTlhEZTVXQ1IvOHM9</response>

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

2019-10-13 19:25:16 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:16 | [Mutex] received everything.

2019-10-13 19:25:16 | [Mutex] isItemNotified: authFailed :: true

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3N4d2xvejAwMjAscj1jaGZSbkxDQnM3RGY5enlmNzBxVA==</auth>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jaGZSbkxDQnM3RGY5enlmNzBxVHJyRXQ5Yk53ZkNqenc0Sjhna1lILHM9NXRORWQxbmpjNWRlT2c9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:16 | user :: user_sxwloz0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y2hmUm5MQ0JzN0RmOXp5ZjcwcVRyckV0OWJOd2ZDanp3NEo4Z2tZSCxwPWpZQUlDdW9XRlExOUk4L3NkVWFaRmlReXg5cWVtMlM1VUZUZGRXNGE1VTQ9</response>

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

2019-10-13 19:25:18 | [Mutex] waiting for: [user]

2019-10-13 19:25:19 | [Mutex] received everything.

2019-10-13 19:25:19 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.090s
2019-10-13 19:25:19 |

2019-10-13 19:25:19 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 19:25:19 | ------------------------------------

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2a875d5d

2019-10-13 19:25:19 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2440b67d}, 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@207f362d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@657dbc46}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@75806801}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:19 PDT 2019}}}}

2019-10-13 19:25:19 | [Mutex] waiting for: [registration]

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5452db92

2019-10-13 19:25:19 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2440b67d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@207f362d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@657dbc46}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@75806801}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:19 PDT 2019}}}}

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@d45516b

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

2019-10-13 19:25:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5524309}

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

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

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

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7364f3c2

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@31a83877

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

2019-10-13 19:25:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1641f920}

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

2019-10-13 19:25:19 | user :: null >> <iq to="localhost" id="XbPXWjHQOU9JzjDs5o5vr24" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 19:25:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@61914b93}

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

2019-10-13 19:25:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@11cbaea}

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@55b2a3e8

2019-10-13 19:25:19 | user :: null >> <iq to="localhost" id="11jT7Fr37q1gPZpYW5rW7uZ" type="set"><query xmlns="jabber:iq:register"><username>user_nzbz090021</username><password>user_nzbz090021</password><email>681ea9cb-0878-49c6-a31d-4f298701e425@localhost</email></query></iq>

2019-10-13 19:25:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f5272b6c}

2019-10-13 19:25:19 | user :: null << <iq xmlns="jabber:client" id="11jT7Fr37q1gPZpYW5rW7uZ" type="result" from="localhost"/>

2019-10-13 19:25:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@25a942a9}

2019-10-13 19:25:19 | [Mutex] received everything.

2019-10-13 19:25:19 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 19:25:19 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5524309, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1641f920]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2440b67d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@207f362d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@657dbc46}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@75806801}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:19 PDT 2019}}}}

2019-10-13 19:25:19 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5524309, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1641f920]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2440b67d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@207f362d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@657dbc46}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@75806801}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:19 PDT 2019}}}}

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3c3837c5

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@58171142

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@187a444b

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@77a9f1e7

2019-10-13 19:25:19 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@ad266c8

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX256YnowOTAwMjEscj1GN0JMb3RIb01EOUtpMkk1NnpaSg==</auth>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GN0JMb3RIb01EOUtpMkk1NnpaSndUSlVZWDNHTUJwWEtBWTBRdU54LHM9K2lQTHR6bEVPNC8rTXc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RjdCTG90SG9NRDlLaTJJNTZ6Wkp3VEpVWVgzR01CcFhLQVkwUXVOeCxwPWZKZHlCRzBOdC9MMGg3RE9OOW94SExlZElpYzJVc2tVb1dWRE9pKy9wRkk9</response>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ZTjBLSnBONTVkVFFKWVhJSkU1OWs1eGJaemNLbjRudCtJUWRmZklyRkpJPQ==</success>

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <iq xmlns="jabber:client" id="zfXkLHp0bAthZ8gJJwhODof" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost << <iq to="user_nzbz090021@localhost/993927746-tigase-15" id="zfXkLHp0bAthZ8gJJwhODof" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_nzbz090021@localhost/993927746-tigase-15</jid></bind></iq>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost/993927746-tigase-15 >> <iq xmlns="jabber:client" id="XeS38HtoU6xv7pPQRWbHPOC" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost/993927746-tigase-15 << <iq to="user_nzbz090021@localhost/993927746-tigase-15" id="XeS38HtoU6xv7pPQRWbHPOC" type="result" xmlns="jabber:client"/>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost/993927746-tigase-15 >> <iq to="localhost" id="4nhEtX6nYfP5kEvhCtcpWlS" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost/993927746-tigase-15 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost/993927746-tigase-15 << <enabled id="2259a285-4b62-41d6-89b1-33e154c708bd" resume="true" location="d4270859fb27" max="60" xmlns="urn:xmpp:sm:3"/>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost/993927746-tigase-15 >> <iq id="lY2bPQNKNUQ7j4gOXlNLxgH" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost/993927746-tigase-15 << <iq xmlns="jabber:client" to="user_nzbz090021@localhost/993927746-tigase-15" id="4nhEtX6nYfP5kEvhCtcpWlS" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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 category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost/993927746-tigase-15 << <iq to="user_nzbz090021@localhost/993927746-tigase-15" id="lY2bPQNKNUQ7j4gOXlNLxgH" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:25:19 | Disconnecting

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

2019-10-13 19:25:19 | [Mutex] notify: [disconnected]

2019-10-13 19:25:19 | [Mutex] received everything.

2019-10-13 19:25:19 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfbnpiejA5MDAyMQAgLSAtIC0gLSAt</auth>

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

2019-10-13 19:25:19 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:19 | [Mutex] received everything.

2019-10-13 19:25:19 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:19 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX256YnowOTAwMjEscj1KTjVBSENxMjRtanNqbk1MbkVnTQ==</auth>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KTjVBSENxMjRtanNqbk1MbkVnTXRPdFRyMlFldHRjN3Q2YXpUbXNWLHM9QTVSRjZYRkRzU051Q3c9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Sk41QUhDcTI0bWpzam5NTG5FZ010T3RUcjJRZXR0Yzd0NmF6VG1zVixwPVd2NlRVK1RtNnhINlNySjJkQ2FmZXRmVGsyVT0=</response>

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

2019-10-13 19:25:19 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:19 | [Mutex] notify: [event, disconnected]

2019-10-13 19:25:19 | [Mutex] received everything.

2019-10-13 19:25:19 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:19 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX256YnowOTAwMjEscj1vRG9pSXV0eGlQSm50RXRGR1hJMg==</auth>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vRG9pSXV0eGlQSm50RXRGR1hJMjM5SXgzdkRyYzdXNHVUVFBrTmhoLHM9QTVSRjZYRkRzU051Q3c9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b0RvaUl1dHhpUEpudEV0RkdYSTIzOUl4M3ZEcmM3VzR1VFRQa05oaCxwPWJrNTRQMytsRzNla0NmeXBNWXhiaGMzL2RoMD0=</response>

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

2019-10-13 19:25:19 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:19 | [Mutex] received everything.

2019-10-13 19:25:19 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:19 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX256YnowOTAwMjEscj1BU3cySFRXdHlUVXh6djBuT21Weg==</auth>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BU3cySFRXdHlUVXh6djBuT21WekRDdjFmZXRmVDUzRUJXT3BPYzAyLHM9QTVSRjZYRkRzU051Q3c9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QVN3MkhUV3R5VFV4enYwbk9tVnpEQ3YxZmV0ZlQ1M0VCV09wT2MwMixwPUpSQU5zUDB0MjZadFQ5VjJ5c1JRTEVLeTdxQT0=</response>

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

2019-10-13 19:25:19 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:19 | [Mutex] received everything.

2019-10-13 19:25:19 | [Mutex] isItemNotified: authFailed :: true

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

2019-10-13 19:25:19 | user :: user_nzbz090021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:20 | user :: user_nzbz090021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX256YnowOTAwMjEscj1CNGhoM2c3czFSZG1UN3FlMFdmVA==</auth>

2019-10-13 19:25:20 | user :: user_nzbz090021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CNGhoM2c3czFSZG1UN3FlMFdmVGdpeTV0ZDNoTVpoMDhoeWtlSEQzLHM9K2lQTHR6bEVPNC8rTXc9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:20 | user :: user_nzbz090021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QjRoaDNnN3MxUmRtVDdxZTBXZlRnaXk1dGQzaE1aaDA4aHlrZUhEMyxwPStEeFdab214TVkyQ1Q2WDhBdDNzaUFVcmsrYjRmY1c2TTRwV0U1QlZjTkU9</response>

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

2019-10-13 19:25:22 | [Mutex] waiting for: [user]

2019-10-13 19:25:22 | [Mutex] received everything.

2019-10-13 19:25:22 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 2.956s
2019-10-13 19:25:22 |

2019-10-13 19:25:22 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 19:25:22 | ------------------------------------

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5018a469

2019-10-13 19:25:22 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5edf401a}, 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@5ae0cf19}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1fe24a21}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@acc9e58}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:22 PDT 2019}}}}

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2eb7d08b

2019-10-13 19:25:22 | [Mutex] waiting for: [registration]

2019-10-13 19:25:22 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5edf401a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@5ae0cf19}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1fe24a21}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@acc9e58}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:22 PDT 2019}}}}

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@72735a43

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

2019-10-13 19:25:22 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7fcdb56e}

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

2019-10-13 19:25:22 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:25:22 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@119dca91

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1be63a1

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

2019-10-13 19:25:22 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@69779097}

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

2019-10-13 19:25:22 | user :: null >> <iq to="localhost" id="S8qiMFuhSMZ3yeKP5hJt8r6" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 19:25:22 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8af38ef6}

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

2019-10-13 19:25:22 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7b832e12}

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@435aab1

2019-10-13 19:25:22 | user :: null >> <iq to="localhost" id="sl24zdSS2pfBnLIBq9DHy6p" type="set"><query xmlns="jabber:iq:register"><username>user_gtexcq0022</username><password>user_gtexcq0022</password><email>9a1ae9fd-58bd-45bc-9416-7a21a8c85429@localhost</email></query></iq>

2019-10-13 19:25:22 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@bd9f14b3}

2019-10-13 19:25:22 | user :: null << <iq xmlns="jabber:client" id="sl24zdSS2pfBnLIBq9DHy6p" type="result" from="localhost"/>

2019-10-13 19:25:22 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@76e462fd}

2019-10-13 19:25:22 | [Mutex] received everything.

2019-10-13 19:25:22 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 19:25:22 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7fcdb56e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@69779097]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5edf401a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@5ae0cf19}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1fe24a21}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@acc9e58}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:22 PDT 2019}}}}

2019-10-13 19:25:22 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7fcdb56e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@69779097]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5edf401a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@3a7a14a8}, 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@5ae0cf19}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1fe24a21}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@acc9e58}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 19:25:22 PDT 2019}}}}

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2342b79e

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@41d3fe5a

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@681ab4f3

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3dbcd087

2019-10-13 19:25:22 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@b747ee9

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d0ZXhjcTAwMjIscj1GZUw3WmR4SzZISlB2dUtndlFMNw==</auth>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GZUw3WmR4SzZISlB2dUtndlFMNzZaMlpMbVlCM3dEeFNNQUZzSHBOLHM9WEVWaWtlNU1qS0Z3VVE9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RmVMN1pkeEs2SEpQdnVLZ3ZRTDc2WjJaTG1ZQjN3RHhTTUFGc0hwTixwPW1NUWRmM1FUc3ExU0pUeUV1aXNFV2RwWk50ZmRHTlFrWSs4bm9WbnF6Skk9</response>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0wcCtrVG0wQjI3MUR6ajZYalhUd1dQZUFCQmtTdXJVZTJrek92M3BEWXRJPQ==</success>

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <iq xmlns="jabber:client" id="1atcJTTXV2fIJN1coZfylWT" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost << <iq to="user_gtexcq0022@localhost/993927746-tigase-16" id="1atcJTTXV2fIJN1coZfylWT" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_gtexcq0022@localhost/993927746-tigase-16</jid></bind></iq>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost/993927746-tigase-16 >> <iq xmlns="jabber:client" id="Z5cNFMGEDHvbnW3kXfV00dH" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost/993927746-tigase-16 << <iq to="user_gtexcq0022@localhost/993927746-tigase-16" id="Z5cNFMGEDHvbnW3kXfV00dH" type="result" xmlns="jabber:client"/>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost/993927746-tigase-16 >> <iq to="localhost" id="FfEuhTdAaxlKJIr0t8nU7y8" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost/993927746-tigase-16 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost/993927746-tigase-16 << <enabled id="67d8cbfd-531d-4a7c-a8d0-b9d1b74550c3" resume="true" location="d4270859fb27" max="60" xmlns="urn:xmpp:sm:3"/>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost/993927746-tigase-16 >> <iq id="pct4rcqhDIyo7Fr37q1gPZp" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost/993927746-tigase-16 << <iq xmlns="jabber:client" to="user_gtexcq0022@localhost/993927746-tigase-16" id="FfEuhTdAaxlKJIr0t8nU7y8" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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 category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost/993927746-tigase-16 << <iq to="user_gtexcq0022@localhost/993927746-tigase-16" id="pct4rcqhDIyo7Fr37q1gPZp" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:25:22 | Disconnecting

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

2019-10-13 19:25:22 | [Mutex] notify: [disconnected]

2019-10-13 19:25:22 | [Mutex] received everything.

2019-10-13 19:25:22 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d0ZXhjcTAwMjIscj1WMnpYZXZMUTl5MGpDSkZhcXc4Wg==</auth>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WMnpYZXZMUTl5MGpDSkZhcXc4Wms4amtqdXltMGFub2JEVWZGdHRZLHM9WEVWaWtlNU1qS0Z3VVE9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VjJ6WGV2TFE5eTBqQ0pGYXF3OFprOGpranV5bTBhbm9iRFVmRnR0WSxwPTczNnF4Q05MTkl1YUhlZUc3RjBVU0dITU5SODFHWHhTZVdqVnNaNGtDUzA9</response>

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

2019-10-13 19:25:22 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:22 | [Mutex] received everything.

2019-10-13 19:25:22 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:22 | [Mutex] notify: [event, disconnected]

2019-10-13 19:25:22 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d0ZXhjcTAwMjIscj04ZkVUVGdnWWQwSkZKY1lYUTFGMQ==</auth>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04ZkVUVGdnWWQwSkZKY1lYUTFGMW9UNUg3cE9QQ2ZLQ3l2SkxWOUttLHM9WEVWaWtlNU1qS0Z3VVE9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OGZFVFRnZ1lkMEpGSmNZWFExRjFvVDVIN3BPUENmS0N5dkpMVjlLbSxwPWZrL2lpOG5qdmZKWjBlM1FyNksxZlJwYXZZZzFIeXhXbnhNSHh5QTllWUk9</response>

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

2019-10-13 19:25:22 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:22 | [Mutex] received everything.

2019-10-13 19:25:22 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 19:25:22 | [Mutex] waiting for: [event]

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d0ZXhjcTAwMjIscj1YM3NFcGoxZmNPYUNEY29iOG5oQw==</auth>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YM3NFcGoxZmNPYUNEY29iOG5oQzRVU0x1YjNQUzdUMlVBanhSUE5oLHM9WEVWaWtlNU1qS0Z3VVE9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WDNzRXBqMWZjT2FDRGNvYjhuaEM0VVNMdWIzUFM3VDJVQWp4UlBOaCxwPXRqbXRFWFU4NC90TUdxTkZsc2krWnFQemFLM1BUMHhYRUhYdXVGUEZ0RjQ9</response>

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

2019-10-13 19:25:22 | [Mutex] notify: [event, authFailed]

2019-10-13 19:25:22 | [Mutex] received everything.

2019-10-13 19:25:22 | [Mutex] isItemNotified: authFailed :: true

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d0ZXhjcTAwMjIscj1OTmdPdXVmY05xWDVjZzdaSlhFdQ==</auth>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OTmdPdXVmY05xWDVjZzdaSlhFdVFQY2NWMDZMNkdCV1hCWWg3MG5HLHM9WEVWaWtlNU1qS0Z3VVE9PSxpPTQwOTY=</challenge>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Tk5nT3V1ZmNOcVg1Y2c3WkpYRXVRUGNjVjA2TDZHQldYQlloNzBuRyxwPTJuSmZSNWh6YW9kSmgyR1pTS05zdmdYR3FXTXV0cDVSZGtqUFB3czhDdW89</response>

2019-10-13 19:25:22 | user :: user_gtexcq0022@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1MdktSZDVyTDlsUXpZNUpDNVV5dk9EV3JaeTBxZFFKQ2FLSXBBeWlqVGZVPQ==</success>

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

2019-10-13 19:25:23 | user :: user_gtexcq0022@localhost >> <iq xmlns="jabber:client" id="L69tdudGnSdClQZiCFpgEAv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 19:25:23 | user :: user_gtexcq0022@localhost << <iq to="user_gtexcq0022@localhost/993927746-tigase-17" id="L69tdudGnSdClQZiCFpgEAv" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_gtexcq0022@localhost/993927746-tigase-17</jid></bind></iq>

2019-10-13 19:25:23 | user :: user_gtexcq0022@localhost/993927746-tigase-17 >> <iq xmlns="jabber:client" id="uytZqYeN19tX6nYfP5kEvhC" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 19:25:23 | user :: user_gtexcq0022@localhost/993927746-tigase-17 << <iq to="user_gtexcq0022@localhost/993927746-tigase-17" id="uytZqYeN19tX6nYfP5kEvhC" type="result" xmlns="jabber:client"/>

2019-10-13 19:25:23 | user :: user_gtexcq0022@localhost/993927746-tigase-17 >> <iq to="localhost" id="ZahXZqYeN19tX6nYfP5kEvh" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 19:25:23 | user :: user_gtexcq0022@localhost/993927746-tigase-17 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 19:25:23 | user :: user_gtexcq0022@localhost/993927746-tigase-17 << <enabled id="2bbd795c-17af-42ea-be2c-c631bb1dde49" resume="true" location="d4270859fb27" max="60" xmlns="urn:xmpp:sm:3"/>

2019-10-13 19:25:23 | user :: user_gtexcq0022@localhost/993927746-tigase-17 >> <iq id="f9czpSZet4BoTWbGodvs2m3" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-10-13 19:25:23 | user :: user_gtexcq0022@localhost/993927746-tigase-17 << <iq xmlns="jabber:client" to="user_gtexcq0022@localhost/993927746-tigase-17" id="ZahXZqYeN19tX6nYfP5kEvh" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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 category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-10-13 19:25:23 | user :: user_gtexcq0022@localhost/993927746-tigase-17 << <iq to="user_gtexcq0022@localhost/993927746-tigase-17" id="f9czpSZet4BoTWbGodvs2m3" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:25:23 | Disconnecting

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

2019-10-13 19:25:23 | [Mutex] notify: [disconnected]

2019-10-13 19:25:23 | [Mutex] received everything.

2019-10-13 19:25:25 | [Mutex] waiting for: [user]

2019-10-13 19:25:25 | [Mutex] received everything.

2019-10-13 19:25:25 | [Mutex] isItemNotified: user:ok:true :: true