Brute Force Prevention

Test duration: 14.827s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.351s
2019-11-24 18:26:59 |

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

2019-11-24 18:26:59 | ------------------------------------

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1c1377b3

2019-11-24 18:26:59 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12d49a41}, 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@16eb1cc3}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@53e9907a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5440db5b}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:26:59 PST 2019}}}}

2019-11-24 18:26:59 | [Mutex] waiting for: [registration]

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@62f04500

2019-11-24 18:26:59 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12d49a41}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@16eb1cc3}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@53e9907a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5440db5b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:26:59 PST 2019}}}}

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2cb35099

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

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

2019-11-24 18:26:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33c66f35}

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

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

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@610ee015

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1b66171

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

2019-11-24 18:26:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@37b7de46}

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

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

2019-11-24 18:26:59 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@9b8f4f28}

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

2019-11-24 18:26:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3788b042}

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@2110f0ee

2019-11-24 18:26:59 | user :: null >> <iq to="localhost" id="fMzj6Czm4eyjHSPFtiTQasp" type="set"><query xmlns="jabber:iq:register"><username>user_l0azjj0027</username><password>user_l0azjj0027</password><email>0cf6956c-72a6-4cf5-8ed9-594eb55fc96b@localhost</email></query></iq>

2019-11-24 18:26:59 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@53bb6c39}

2019-11-24 18:26:59 | user :: null << <iq from="localhost" xmlns="jabber:client" id="fMzj6Czm4eyjHSPFtiTQasp" type="result"/>

2019-11-24 18:26:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@139fb054}

2019-11-24 18:26:59 | [Mutex] received everything.

2019-11-24 18:26:59 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 18:26:59 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33c66f35, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@37b7de46]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12d49a41}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@16eb1cc3}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@53e9907a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5440db5b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:26:59 PST 2019}}}}

2019-11-24 18:26:59 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33c66f35, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@37b7de46]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12d49a41}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@16eb1cc3}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@53e9907a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5440db5b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:26:59 PST 2019}}}}

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1ad3098f

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@68abb037

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4e1aba4c

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2069aecb

2019-11-24 18:26:59 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@22f45438

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

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

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

2019-11-24 18:26:59 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1mc0JMeTdxQ29ZQ09UQzR6NElaeA==</auth>

2019-11-24 18:26:59 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mc0JMeTdxQ29ZQ09UQzR6NElaeGxDNWl5T1JhREZ6ZTFDSnIzTVVTLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:26:59 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZnNCTHk3cUNvWUNPVEM0ejRJWnhsQzVpeU9SYURGemUxQ0pyM01VUyxwPXRUdWZwUlBCOEc5bzZJemU3ZWdTeFFyaEFMQWo0d3Bsb0poWDdaUytjdU09</response>

2019-11-24 18:26:59 | user :: user_l0azjj0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0raWFVOVFrVVA3bXhNSnhndHJmNmxMUE5manZjcmNCZk1QVkFOSXdQUkdjPQ==</success>

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

2019-11-24 18:26:59 | user :: user_l0azjj0027@localhost >> <iq xmlns="jabber:client" id="OQJLKQMEv5EnLFGFogENTPE" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-24 18:26:59 | user :: user_l0azjj0027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" to="user_l0azjj0027@localhost/993927746-tigase-19" id="GNyaLQ8DtqgRWeycBh29jLS" type="result"/>

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

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

2019-11-24 18:26:59 | user :: user_l0azjj0027@localhost/993927746-tigase-19 << <enabled xmlns="urn:xmpp:sm:3" resume="true" max="60" location="d4270859fb27" id="318bb965-f95a-4b9e-a0f9-7449971efd83"/>

2019-11-24 18:26:59 | user :: user_l0azjj0027@localhost/993927746-tigase-19 >> <iq id="DxIvk06DACBpi0lUaqW5fY1" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-24 18:26:59 | user :: user_l0azjj0027@localhost/993927746-tigase-19 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-24 18:26:59 | user :: user_l0azjj0027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" to="user_l0azjj0027@localhost/993927746-tigase-19" id="DxIvk06DACBpi0lUaqW5fY1" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:26:59 | Disconnecting

2019-11-24 18:26:59 | [Mutex] notify: [disconnected]

2019-11-24 18:26:59 | [Mutex] received everything.

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

2019-11-24 18:26:59 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj15WGI2bjF0SThuZG55SGhvY28xTQ==</auth>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15WGI2bjF0SThuZG55SGhvY28xTVRTR0FrTnY5UVNHdU50dTBINUJRLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eVhiNm4xdEk4bmRueUhob2NvMU1UU0dBa052OVFTR3VOdHUwSDVCUSxwPU1JTmJhdkJlcXZiNThwcm92Z3ZQank5My9ocmFZOGdWQjlzVzFoeHJJemc9</response>

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

2019-11-24 18:27:00 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:00 | [Mutex] received everything.

2019-11-24 18:27:00 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:00 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1ES1RQWTdoTXZmYkVaNkpCcnoxbA==</auth>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ES1RQWTdoTXZmYkVaNkpCcnoxbDdDdlNGNjVkSWtremROQTVUWW0yLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9REtUUFk3aE12ZmJFWjZKQnJ6MWw3Q3ZTRjY1ZElra3pkTkE1VFltMixwPWFkNGxlcnUyR3VNdTdrSFNGTVZ1RTh3NDVYanlTM296alZ2ajFpbUN5THM9</response>

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

2019-11-24 18:27:00 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:00 | [Mutex] received everything.

2019-11-24 18:27:00 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:00 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1VbHN0aVF4S2ZSUWh3Y1VTY2JkRQ==</auth>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VbHN0aVF4S2ZSUWh3Y1VTY2JkRXpmVGNIZjcwTzgxZno5MkZDdEVVLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VWxzdGlReEtmUlFod2NVU2NiZEV6ZlRjSGY3ME84MWZ6OTJGQ3RFVSxwPW42RGw4WEVOR25reG95RUVjZyt5bXdWSERjYUw2MVpNWjhBYTUxS2cwbkU9</response>

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

2019-11-24 18:27:00 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:00 | [Mutex] received everything.

2019-11-24 18:27:00 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:00 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1WNFFjSEN0WVl1QkxHTVRVQzR6Zg==</auth>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WNFFjSEN0WVl1QkxHTVRVQzR6ZlQ0TVRRWnFmc1BZWkVyUFd2ekVOLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VjRRY0hDdFlZdUJMR01UVUM0emZUNE1UUVpxZnNQWVpFclBXdnpFTixwPXdhTGRQM2h2RVEzdXRNbC9PUThTRmJISUZMbVFuamFRVmUwTm5rSHpMalU9</response>

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

2019-11-24 18:27:00 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:00 | [Mutex] received everything.

2019-11-24 18:27:00 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:00 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1HZlR2eGdYNGdjQ044Wm5uRzFuWA==</auth>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HZlR2eGdYNGdjQ044Wm5uRzFuWGp0M3lYYWVicmVSSWQwdGI1SkVqLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R2ZUdnhnWDRnY0NOOFpubkcxblhqdDN5WGFlYnJlUklkMHRiNUpFaixwPW1VTGZ2TzdPR3RuMDR2bXB3REJBRGdMaVpBcW5yM3NzRWdrMGdCRHVvQ2c9</response>

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

2019-11-24 18:27:00 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:00 | [Mutex] received everything.

2019-11-24 18:27:00 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:00 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1HVkJrWDhMa1FvV09hYWVyQjFsZQ==</auth>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HVkJrWDhMa1FvV09hYWVyQjFsZWpubnM3cmRMQjFLVjFJdTdNUGhuLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R1ZCa1g4TGtRb1dPYWFlckIxbGVqbm5zN3JkTEIxS1YxSXU3TVBobixwPWF5Qmx3VUEzYjN1RDJYOEloWDdvMnJGdm5adGJwbEkwSFA3VGx5MTRSNjA9</response>

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

2019-11-24 18:27:00 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:00 | [Mutex] received everything.

2019-11-24 18:27:00 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:00 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1SejBMV1N4cnEwTU9McW9vR0NvcQ==</auth>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SejBMV1N4cnEwTU9McW9vR0NvcXRoWWRTeHFnVlhwMjlaZHpzYnFELHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UnowTFdTeHJxME1PTHFvb0dDb3F0aFlkU3hxZ1ZYcDI5WmR6c2JxRCxwPVdlZ0NrRnF4eU9OMGhmNldXSnEzd2k5RVcvdEpRTm1DM1VlWDhmVjV6Q009</response>

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

2019-11-24 18:27:00 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:00 | [Mutex] received everything.

2019-11-24 18:27:00 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:00 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1qZTRSUVJ4SXZhYnljOWJpREE1Qw==</auth>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qZTRSUVJ4SXZhYnljOWJpREE1Q2JraXBzeVhxc3VWMHNZRGkwY0JYLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9amU0UlFSeEl2YWJ5YzliaURBNUNia2lwc3lYcXN1VjBzWURpMGNCWCxwPUhWQzRYSno3akhPZ0xGZ0xXalNOK3p0cTVPdVlzVnlNVVpLaXExU0tQem89</response>

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

2019-11-24 18:27:00 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:00 | [Mutex] received everything.

2019-11-24 18:27:00 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:00 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1uVmJzOUVMYXJCWVVPMjRjbzVmTw==</auth>

2019-11-24 18:27:00 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uVmJzOUVMYXJCWVVPMjRjbzVmTzdvdlhid0NuNTMyVXNTUTNnU3BzLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9blZiczlFTGFyQllVTzI0Y281Zk83b3ZYYndDbjUzMlVzU1EzZ1NwcyxwPXQzZGVXNEVvTENPcENrQjdyWGs4NW1CMjNScEVZbFU1aVBOaFlCSWtiK1E9</response>

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

2019-11-24 18:27:01 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:01 | [Mutex] notify: [event, disconnected]

2019-11-24 18:27:01 | [Mutex] received everything.

2019-11-24 18:27:01 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:01 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1mUzV3bFF4UUtSUW9yNE11dlBhcA==</auth>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mUzV3bFF4UUtSUW9yNE11dlBhcEZ0Zm82MEhkRFpjZFd5SzQ0UThILHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZlM1d2xReFFLUlFvcjRNdXZQYXBGdGZvNjBIZERaY2RXeUs0NFE4SCxwPTZyZ1hvVXJGM0VjS091dmJpMzUrZGdYSXFYY3dYTUhoQnBvYTdHdklTaWc9</response>

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

2019-11-24 18:27:01 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:01 | [Mutex] received everything.

2019-11-24 18:27:01 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:01 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1pb3BGZFJlN2lNZXFhZEtFNFpOag==</auth>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pb3BGZFJlN2lNZXFhZEtFNFpOanlmVWJGSHRwZ1lxQlM4aE5UR2h5LHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aW9wRmRSZTdpTWVxYWRLRTRaTmp5ZlViRkh0cGdZcUJTOGhOVEdoeSxwPXJCQlFuVXBpaWNVUWFtTU10K1BqbFBTejlFZmIvTFV4amFYUXR5bDFqSlU9</response>

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

2019-11-24 18:27:01 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:01 | [Mutex] received everything.

2019-11-24 18:27:01 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:01 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1vUUI4YWE4QWdRdFhibEpzTWM3dQ==</auth>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vUUI4YWE4QWdRdFhibEpzTWM3dXFwaVR2UFZOQktyZk1rV08wdW40LHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b1FCOGFhOEFnUXRYYmxKc01jN3VxcGlUdlBWTkJLcmZNa1dPMHVuNCxwPVNEVE4wVDFPamJRYjVYaTk0a2RnQUJTeTAzZ2lVWEVMR01mUys4MUx0YmM9</response>

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

2019-11-24 18:27:01 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:01 | [Mutex] received everything.

2019-11-24 18:27:01 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:01 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1udmd1N1EyRUNCa0wwWmFsRHQwYQ==</auth>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1udmd1N1EyRUNCa0wwWmFsRHQwYWFzSWFvejZCbExZU1l0UlpoeTdNLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bnZndTdRMkVDQmtMMFphbER0MGFhc0lhb3o2QmxMWVNZdFJaaHk3TSxwPTBhRHliRVNZTUlFODhHa3RMTm0wTEd0REYreCszUnBlaHlxaHhhVTUyenc9</response>

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

2019-11-24 18:27:01 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:01 | [Mutex] received everything.

2019-11-24 18:27:01 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:01 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1FNFdRNDVkUEpLbFhmeGxyc1dnTg==</auth>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FNFdRNDVkUEpLbFhmeGxyc1dnTmJ2NFI5TmRWSjViTzlwN0dDY3haLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RTRXUTQ1ZFBKS2xYZnhscnNXZ05idjRSOU5kVko1Yk85cDdHQ2N4WixwPU4zWG56bkhkM0tzYk03dHRWNUJzL3lLbUlBT2pkcENJREYydnMzeHNUbG89</response>

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

2019-11-24 18:27:01 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:01 | [Mutex] received everything.

2019-11-24 18:27:01 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:01 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1QekRIMGtXdTNHT1pGb1JKclpvZA==</auth>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QekRIMGtXdTNHT1pGb1JKclpvZGY2dmZpZVBPd0U3N21OaUNDcm1oLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UHpESDBrV3UzR09aRm9SSnJab2RmNnZmaWVQT3dFNzdtTmlDQ3JtaCxwPWIyZmloV0c4QnFhaFd3bG9EUERZVFg5a2lncG5KTUVrb3pTV1ZLYUxaVTQ9</response>

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

2019-11-24 18:27:01 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:01 | [Mutex] notify: [event, disconnected]

2019-11-24 18:27:01 | [Mutex] received everything.

2019-11-24 18:27:01 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:01 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1jNGdyNE1rMWRBMzYwUGxJbW9TWQ==</auth>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jNGdyNE1rMWRBMzYwUGxJbW9TWXNHR2JRVGNCTFZMSDJCbGdnSWo5LHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:01 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YzRncjRNazFkQTM2MFBsSW1vU1lzR0diUVRjQkxWTEgyQmxnZ0lqOSxwPWdPTTZqemV0QVdaRE12U3puRWZYZ0NMNUR4a0tmRTVSWU5TR1krUDdCMGs9</response>

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

2019-11-24 18:27:01 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:01 | [Mutex] received everything.

2019-11-24 18:27:01 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:01 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1sRTlHdXFTcXg0ZmNncWM0d3pwVA==</auth>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sRTlHdXFTcXg0ZmNncWM0d3pwVHN2T0VDNlVvOUV3NHRrNDk0Y3JQLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bEU5R3VxU3F4NGZjZ3FjNHd6cFRzdk9FQzZVbzlFdzR0azQ5NGNyUCxwPUYreFEyYVk5MzFWVkM5d0VBRnZHR1F3OUFkWC9yWlhiTmFsa2VYMHc4MGM9</response>

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

2019-11-24 18:27:02 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:02 | [Mutex] received everything.

2019-11-24 18:27:02 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:02 | [Mutex] notify: [event, disconnected]

2019-11-24 18:27:02 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1remUxaFRGZVhtdjBBdnNoVkRjbQ==</auth>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1remUxaFRGZVhtdjBBdnNoVkRjbVJYTEpjRTJaa0Z4ZWhhdlk4b3NOLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a3plMWhURmVYbXYwQXZzaFZEY21SWExKY0UyWmtGeGVoYXZZOG9zTixwPU1hYUxVbWN4NlZZMDZzWWVhVnJXWkdUaUxFV1dSVzlncC93bWViMkhkdXc9</response>

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

2019-11-24 18:27:02 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:02 | [Mutex] received everything.

2019-11-24 18:27:02 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:02 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1JQVFKbDhuSkpGN0Q0VVlIT1dIUw==</auth>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JQVFKbDhuSkpGN0Q0VVlIT1dIU2R1TVhieUNQM3UxaGJ4d3ByalNoLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SUFRSmw4bkpKRjdENFVZSE9XSFNkdU1YYnlDUDN1MWhieHdwcmpTaCxwPS9aaVltcG91RHJSbTBtb2V0cGRmZ3VVOFk2VlJvVjdxRDZmUUlBQXZKc0E9</response>

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

2019-11-24 18:27:02 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:02 | [Mutex] received everything.

2019-11-24 18:27:02 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:02 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1wbHJaSlpwQ3huZFV5N1h0UThreQ==</auth>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wbHJaSlpwQ3huZFV5N1h0UThreTlPcVRsWFpSRndtVFdUUjI3ZHlhLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cGxyWkpacEN4bmRVeTdYdFE4a3k5T3FUbFhaUkZ3bVRXVFIyN2R5YSxwPTFDVTVjZXl6bkhjci9DR0tveGlPeW1ibUVNZWRMZm5PWnhpOStwU2EzVms9</response>

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

2019-11-24 18:27:02 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:02 | [Mutex] notify: [event, disconnected]

2019-11-24 18:27:02 | [Mutex] received everything.

2019-11-24 18:27:02 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:02 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1wUmFoeFFLOTM1V1F4WWIxZVJtaQ==</auth>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wUmFoeFFLOTM1V1F4WWIxZVJtaTgzM3JpYjNlYWVkWk9UaGZIUENsLHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cFJhaHhRSzkzNVdReFliMWVSbWk4MzNyaWIzZWFlZFpPVGhmSFBDbCxwPWtTdTlSVXBSdWZDUFRSU1RXdGdIWkJsQ2RUQkp1L3ZubFY3Wnh5Q3lvbE09</response>

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

2019-11-24 18:27:02 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:02 | [Mutex] received everything.

2019-11-24 18:27:02 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2wwYXpqajAwMjcscj1oNkZRS3BJMFhQNU5aUTlIVFh2Sg==</auth>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oNkZRS3BJMFhQNU5aUTlIVFh2Sk94V2k3ZldPc1VkclEwazFEdVU4LHM9cDlTSllnMDFhc2RRS2c9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:02 | user :: user_l0azjj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aDZGUUtwSTBYUDVOWlE5SFRYdkpPeFdpN2ZXT3NVZHJRMGsxRHVVOCxwPWhjQUNEL09iM1dBZTZWQ3Z1V0p6VmhVVUZiRTJvckVoalMweFhrNkV2RHM9</response>

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

2019-11-24 18:27:04 | [Mutex] waiting for: [user]

2019-11-24 18:27:04 | [Mutex] received everything.

2019-11-24 18:27:04 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.226s
2019-11-24 18:27:04 |

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

2019-11-24 18:27:04 | ------------------------------------

2019-11-24 18:27:04 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6cd17fca

2019-11-24 18:27:04 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@62169c20}, 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@662914ba}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@232b961b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4463929b}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:04 PST 2019}}}}

2019-11-24 18:27:04 | [Mutex] waiting for: [registration]

2019-11-24 18:27:04 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1242f1ab

2019-11-24 18:27:04 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@62169c20}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@662914ba}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@232b961b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4463929b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:04 PST 2019}}}}

2019-11-24 18:27:04 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@3ce0ab9d

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

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

2019-11-24 18:27:04 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@43046954}

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

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

2019-11-24 18:27:04 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1babcce5

2019-11-24 18:27:04 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1ee1b992

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

2019-11-24 18:27:04 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@27e44590}

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

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

2019-11-24 18:27:04 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d8b4f843}

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

2019-11-24 18:27:04 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@474ad6f1}

2019-11-24 18:27:04 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@243f619

2019-11-24 18:27:04 | user :: null >> <iq to="localhost" id="kLgQMEv5EnLFGFogENTPEmP" type="set"><query xmlns="jabber:iq:register"><username>user_w12p0n0028</username><password>user_w12p0n0028</password><email>6d3dec6d-427f-4ee7-bf22-44759c8c4aff@localhost</email></query></iq>

2019-11-24 18:27:04 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8f658e86}

2019-11-24 18:27:05 | user :: null << <iq from="localhost" xmlns="jabber:client" id="kLgQMEv5EnLFGFogENTPEmP" type="result"/>

2019-11-24 18:27:05 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@117de2ea}

2019-11-24 18:27:05 | [Mutex] received everything.

2019-11-24 18:27:05 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 18:27:05 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@43046954, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@27e44590]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@62169c20}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@662914ba}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@232b961b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4463929b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:05 PST 2019}}}}

2019-11-24 18:27:05 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@43046954, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@27e44590]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@62169c20}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@662914ba}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@232b961b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4463929b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:05 PST 2019}}}}

2019-11-24 18:27:05 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1430fd90

2019-11-24 18:27:05 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@5dc5cb9

2019-11-24 18:27:05 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@18b29125

2019-11-24 18:27:05 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@66a65a6b

2019-11-24 18:27:05 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@75e9e752

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

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

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

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxMnAwbjAwMjgscj1mRWw2NWFRZTBQMHdubXo0c3ZlaQ==</auth>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mRWw2NWFRZTBQMHdubXo0c3ZlaWZaRzN5M2thbVJUc2tHaXg0V1VjLHM9Nk02NmRkNEFJa05vRGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZkVsNjVhUWUwUDB3bm16NHN2ZWlmWkczeTNrYW1SVHNrR2l4NFdVYyxwPTBBQThyaWE3dUNyNlV4VzVYMGluK2Q5MGpldXlWeEVHSnFlVlVVTjdvK2c9</response>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0xOTNRK01WbVVyKy9MdTl0czhib05LZFZ5eWhuNTE5N1UyMkdTR0hsS1djPQ==</success>

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

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <iq xmlns="jabber:client" id="CyBezsgCFEKRVk4taGs0dvu" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="oMfxybnT8zcSSfNDgAhS6i1" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" to="user_w12p0n0028@localhost/993927746-tigase-20" id="oMfxybnT8zcSSfNDgAhS6i1" type="result"/>

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

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

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost/993927746-tigase-20 << <enabled xmlns="urn:xmpp:sm:3" resume="true" max="60" location="d4270859fb27" id="74debe8e-6eca-443b-a95d-3dcc8663ce83"/>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost/993927746-tigase-20 >> <iq id="8IZgSQ7yyt9MYhMUUU17Iv1" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost/993927746-tigase-20 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" to="user_w12p0n0028@localhost/993927746-tigase-20" id="8IZgSQ7yyt9MYhMUUU17Iv1" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:27:05 | Disconnecting

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

2019-11-24 18:27:05 | [Mutex] notify: [disconnected]

2019-11-24 18:27:05 | [Mutex] received everything.

2019-11-24 18:27:05 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxMnAwbjAwMjgscj1uR3hkRzFoYVdPTUNRZHBtRVhnbQ==</auth>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uR3hkRzFoYVdPTUNRZHBtRVhnbVZmVXFTSFhEQkhtenVwbEVoMnMxLHM9Nk02NmRkNEFJa05vRGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bkd4ZEcxaGFXT01DUWRwbUVYZ21WZlVxU0hYREJIbXp1cGxFaDJzMSxwPUFicVhvVHF6RUFBTnpmSG5Od1hGODBuY0wyVWM1MmhjMDVOdDU3aldITTQ9</response>

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

2019-11-24 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:05 | [Mutex] received everything.

2019-11-24 18:27:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:05 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxMnAwbjAwMjgscj1xcnlIV2YzSmhuTmtFeHE0dmRTNA==</auth>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xcnlIV2YzSmhuTmtFeHE0dmRTNHVZTEFqczNzVnZOVUVBNjJueGFvLHM9Nk02NmRkNEFJa05vRGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cXJ5SFdmM0pobk5rRXhxNHZkUzR1WUxBanMzc1Z2TlVFQTYybnhhbyxwPVJsNFRMY0w1VUErTVNaOWNWMm15cGpTSTZ6NzRobkZuYWU2MGtsSWZML2s9</response>

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

2019-11-24 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:05 | [Mutex] received everything.

2019-11-24 18:27:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:05 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxMnAwbjAwMjgscj14ZXdTQUJPYkJ1Q0tiQlNlR0VlUw==</auth>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14ZXdTQUJPYkJ1Q0tiQlNlR0VlU2tuWVlDU0JjZnpwek5jYzkzMFd4LHM9Nk02NmRkNEFJa05vRGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eGV3U0FCT2JCdUNLYkJTZUdFZVNrbllZQ1NCY2Z6cHpOY2M5MzBXeCxwPTVrb1NrUU5TL2xsbkF1cWZ2M3BpdllTZU92YXJxbmpydTFKTW1WbXhpYzA9</response>

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

2019-11-24 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:05 | [Mutex] received everything.

2019-11-24 18:27:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:05 | [Mutex] notify: [event, disconnected]

2019-11-24 18:27:05 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxMnAwbjAwMjgscj1JVkxlOUtvOG9KQ0pVTng4c2dtUg==</auth>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JVkxlOUtvOG9KQ0pVTng4c2dtUlhoWVJkaWVSUXE3bzkyS0Z0Rk9qLHM9Nk02NmRkNEFJa05vRGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SVZMZTlLbzhvSkNKVU54OHNnbVJYaFlSZGllUlFxN285MktGdEZPaixwPWdzdEFoU0FzRy90NUxuUVNwU0VaeEdIL1FhZ3pya2ZQcVNKM3ByWU9VZUE9</response>

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

2019-11-24 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:05 | [Mutex] received everything.

2019-11-24 18:27:05 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxMnAwbjAwMjgscj1yY3R4OUFqYlRNWkFINUxGWHZXRw==</auth>

2019-11-24 18:27:05 | user :: user_w12p0n0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yY3R4OUFqYlRNWkFINUxGWHZXR3BjS0czSnFmOVFSeWRUNlFkbWZBLHM9Nk02NmRkNEFJa05vRGc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:06 | user :: user_w12p0n0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cmN0eDlBamJUTVpBSDVMRlh2V0dwY0tHM0pxZjlRUnlkVDZRZG1mQSxwPVNQbWZZM0lyUm9tY0xsN2RFRkoybW1WY3RpeDRQWHM5ZTBQY2pIbzYrSGM9</response>

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

2019-11-24 18:27:08 | [Mutex] waiting for: [user]

2019-11-24 18:27:08 | [Mutex] received everything.

2019-11-24 18:27:08 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.061s
2019-11-24 18:27:08 |

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

2019-11-24 18:27:08 | ------------------------------------

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@573e7018

2019-11-24 18:27:08 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@59f9948f}, 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@5dc61b68}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@18c49eb4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3c5e9304}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:08 PST 2019}}}}

2019-11-24 18:27:08 | [Mutex] waiting for: [registration]

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@299625ec

2019-11-24 18:27:08 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@59f9948f}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@5dc61b68}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@18c49eb4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3c5e9304}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:08 PST 2019}}}}

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@44e676ed

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

2019-11-24 18:27:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@78eb61fb}

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

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

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

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@30e50b51

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2844f1e4

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

2019-11-24 18:27:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5fe2bb1f}

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

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

2019-11-24 18:27:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2566961e}

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

2019-11-24 18:27:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7ca5fda1}

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6402cee7

2019-11-24 18:27:08 | user :: null >> <iq to="localhost" id="i5YfIMEoZ3Afv9EBg08LPHo" type="set"><query xmlns="jabber:iq:register"><username>user_bbqzuv0029</username><password>user_bbqzuv0029</password><email>0185d868-30f6-4069-b58a-96280743b2a4@localhost</email></query></iq>

2019-11-24 18:27:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6fa0f175}

2019-11-24 18:27:08 | user :: null << <iq from="localhost" xmlns="jabber:client" id="i5YfIMEoZ3Afv9EBg08LPHo" type="result"/>

2019-11-24 18:27:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6bc6d852}

2019-11-24 18:27:08 | [Mutex] received everything.

2019-11-24 18:27:08 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 18:27:08 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@78eb61fb, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5fe2bb1f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@59f9948f}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@5dc61b68}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@18c49eb4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3c5e9304}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:08 PST 2019}}}}

2019-11-24 18:27:08 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@78eb61fb, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5fe2bb1f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@59f9948f}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@5dc61b68}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@18c49eb4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3c5e9304}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:08 PST 2019}}}}

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2136ac76

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@722d0504

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2a9850

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@5d73c44f

2019-11-24 18:27:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4932968b

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

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

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

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2JicXp1djAwMjkscj1ZZXhTb2pyQXZrZGNTUDlMajRFOA==</auth>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZZXhTb2pyQXZrZGNTUDlMajRFOFg5M2dYdWxtUFR3QWthVDlwalNnLHM9Zjdsd05OaWRLUldyZnc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WWV4U29qckF2a2RjU1A5TGo0RThYOTNnWHVsbVBUd0FrYVQ5cGpTZyxwPXFOck96L2VGZGVPU2hTU0duUkFvQ0dOVTR3QWd3dWJsZHZOditTUHRYNlk9</response>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VQXlaK0lmU2hZbkRrVUt0cXZCcjNZRkc3aUVrNWRzUks3eEUvZUJsMHRnPQ==</success>

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

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <iq xmlns="jabber:client" id="3beJv04fOY2vk6zlaKPS6iG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" to="user_bbqzuv0029@localhost/993927746-tigase-21" id="v0FmcwxnNAezsgCFEKRVk4t" type="result"/>

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

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

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost/993927746-tigase-21 << <enabled xmlns="urn:xmpp:sm:3" resume="true" max="60" location="d4270859fb27" id="a3226d7f-9d5d-4adc-93ef-bd9c561af730"/>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost/993927746-tigase-21 >> <iq id="QXseycBh29jLS3aOKZhBcs1" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" to="user_bbqzuv0029@localhost/993927746-tigase-21" id="QXseycBh29jLS3aOKZhBcs1" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:27:08 | Disconnecting

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

2019-11-24 18:27:08 | [Mutex] notify: [disconnected]

2019-11-24 18:27:08 | [Mutex] received everything.

2019-11-24 18:27:08 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2JicXp1djAwMjkscj16bHJSWVhNOVZJQk5zVlRXT0VEcA==</auth>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16bHJSWVhNOVZJQk5zVlRXT0VEcE91YXdnY0hjOVluQjNYRUxKaWVXLHM9MVZnNHNqYk04ak5ONmc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9emxyUllYTTlWSUJOc1ZUV09FRHBPdWF3Z2NIYzlZbkIzWEVMSmllVyxwPU10SHE2YWt6STYzczBSZFFPQnhPaUt1bjk3VT0=</response>

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

2019-11-24 18:27:08 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:08 | [Mutex] received everything.

2019-11-24 18:27:08 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:08 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2JicXp1djAwMjkscj1IaGwzMmNBRm1ZaW1rcUoweGtxNQ==</auth>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IaGwzMmNBRm1ZaW1rcUoweGtxNWJHbDFvMUtqZGIxOWhQUmt0aE02LHM9MVZnNHNqYk04ak5ONmc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SGhsMzJjQUZtWWlta3FKMHhrcTViR2wxbzFLamRiMTloUFJrdGhNNixwPVhlNVZYZ3Q2eDRaU0tsbDVTUHdGejZySlpVST0=</response>

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

2019-11-24 18:27:08 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:08 | [Mutex] received everything.

2019-11-24 18:27:08 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:08 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2JicXp1djAwMjkscj1pTm9HSVppejVrc0dobzBmak5rcg==</auth>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pTm9HSVppejVrc0dobzBmak5rclBQQnBkMGJQRnY2VTNOU2hFaGMwLHM9Zjdsd05OaWRLUldyZnc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aU5vR0laaXo1a3NHaG8wZmpOa3JQUEJwZDBiUEZ2NlUzTlNoRWhjMCxwPWVOd3hPZUhUZ1ZRT2txMjFsVStBL0pUK2RuOGIxR1R6YmZHYzJZaXU5S0U9</response>

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

2019-11-24 18:27:08 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:08 | [Mutex] received everything.

2019-11-24 18:27:08 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 18:27:08 | [Mutex] waiting for: [event]

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

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

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

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2JicXp1djAwMjkscj1WQlVzbnJpTmR4VXBpZklMQ1VuZA==</auth>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WQlVzbnJpTmR4VXBpZklMQ1VuZFlRQ1RreFVGQzFENmN3Z1VPb1k2LHM9Zjdsd05OaWRLUldyZnc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:08 | user :: user_bbqzuv0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VkJVc25yaU5keFVwaWZJTENVbmRZUUNUa3hVRkMxRDZjd2dVT29ZNixwPTExYThoRk1qSnA3MXptOVN5enR5d2V3OWNkenQwVzZmU2s4ZGtMZzNOem89</response>

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

2019-11-24 18:27:09 | [Mutex] notify: [event, authFailed]

2019-11-24 18:27:09 | [Mutex] received everything.

2019-11-24 18:27:09 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-24 18:27:09 | user :: user_bbqzuv0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2JicXp1djAwMjkscj1VcWR2SHdaajhxYzBZbkdCaExxWg==</auth>

2019-11-24 18:27:09 | user :: user_bbqzuv0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VcWR2SHdaajhxYzBZbkdCaExxWnNwRk1YcDBsWHB1SXRxRXBzc3FTLHM9Zjdsd05OaWRLUldyZnc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:09 | user :: user_bbqzuv0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VXFkdkh3Wmo4cWMwWW5HQmhMcVpzcEZNWHAwbFhwdUl0cUVwc3NxUyxwPXRqQ3FrN3pQNmM4bllMbkNyQXU2L2JhK1grMGlOMGc0SVFoNU1NOEJKclE9</response>

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

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

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

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

testThreeInvalidLogins 2.927s
2019-11-24 18:27:11 |

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

2019-11-24 18:27:11 | ------------------------------------

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3a71976d

2019-11-24 18:27:11 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@34b67e53}, 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@3089fc1d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@758b7468}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@43774f4b}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:11 PST 2019}}}}

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

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@44b4e590

2019-11-24 18:27:11 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@34b67e53}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@3089fc1d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@758b7468}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@43774f4b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:11 PST 2019}}}}

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@3ba2800f

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

2019-11-24 18:27:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@15a48b27}

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

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

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

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6c5083cf

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@fab73b0

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

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

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

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

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

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

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

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@794cc53b

2019-11-24 18:27:11 | user :: null >> <iq to="localhost" id="BQZWWZiWYn4Axh2ujQ2aq3b" type="set"><query xmlns="jabber:iq:register"><username>user_8lttws0030</username><password>user_8lttws0030</password><email>7aa68248-45fd-41e6-81f4-44d5f73b3c83@localhost</email></query></iq>

2019-11-24 18:27:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@175e0ccf}

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

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

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

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

2019-11-24 18:27:11 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@15a48b27, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@20a628b2]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@34b67e53}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@3089fc1d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@758b7468}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@43774f4b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:11 PST 2019}}}}

2019-11-24 18:27:11 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@15a48b27, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@20a628b2]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@34b67e53}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@3089fc1d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@758b7468}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@43774f4b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 18:27:11 PST 2019}}}}

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3c5c51fe

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7e65cfa5

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@619fb84f

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3c96e7ba

2019-11-24 18:27:11 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@629b9277

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

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

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

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

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04NlFXQ2JrVENJbDFoaDVpVEhKYXNyS2REVVJNTnl4SFRCQXVxNUh3LHM9KzlXTkdVRFIwS1ZJNmc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ODZRV0Nia1RDSWwxaGg1aVRISmFzcktkRFVSTU55eEhUQkF1cTVIdyxwPThKQ1U0MW8xM2pEbmV0cXIxcWlFd2o1WExsTTd3RERqWFBvZzE2b3ZKTkU9</response>

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ObURvNWJJOE1weGtEY3pqQ3BYYk5nUFJvaE1Pei9rVktvcE9YYzVBUHVRPQ==</success>

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

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

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

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

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" to="user_8lttws0030@localhost/993927746-tigase-22" id="EWdIMEJM0nXocJGIw8t1w7f" type="result"/>

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

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

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost/993927746-tigase-22 << <enabled xmlns="urn:xmpp:sm:3" resume="true" max="60" location="d4270859fb27" id="18a4aea3-b3b9-470d-9e8a-de42d7680b7d"/>

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost/993927746-tigase-22 >> <iq id="GdY0rcQ3j6Czm4eyjHSPFti" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

2019-11-24 18:27:11 | Disconnecting

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

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

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

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

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

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

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

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

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tS3kySDNEWUk4bnprQWUwUFFDdGVhd0dYaUx4eEFTa3Bua2Z2bnRXLHM9KzlXTkdVRFIwS1ZJNmc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bUt5MkgzRFlJOG56a0FlMFBRQ3RlYXdHWGlMeHhBU2twbmtmdm50VyxwPUZDL1RHT0JTZ3IvN2ZPd1FkZHdIU1FJM1VvRnA0aHE2eXpUSVJLMFBYMGM9</response>

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

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

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

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

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

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

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

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

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

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vT3RkQ1U2cE1mTEMzVjNPQVdpSm5ZSTJPMnJqTW9XWXJBQUxSbGt5LHM9KzlXTkdVRFIwS1ZJNmc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b090ZENVNnBNZkxDM1YzT0FXaUpuWUkyTzJyak1vV1lyQUFMUmxreSxwPTdxU1UyckhxUjlRZVZoOGNCaVpnbzVrV2pSRngydjZqb0RpWWVsdUx0aW89</response>

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

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

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

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

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

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

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

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

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

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wRzFid25nUGVldURUWW81cjVZa3FKbkVDeklkVTlwY0FubE5qQ0MwLHM9KzlXTkdVRFIwS1ZJNmc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cEcxYnduZ1BlZXVEVFlvNXI1WWtxSm5FQ3pJZFU5cGNBbmxOakNDMCxwPVF5MnM0am9YdUJoQkIxdUVuR1ZKbzVxclNENmVjWGtFYW1QYkcwL1Bkdms9</response>

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

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

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

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

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

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

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

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

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01dUtKVUNvcElIZzR0YVlVVWNhcXl1YkNMMlh4ZGxNbEhiN3VCOHByLHM9KzlXTkdVRFIwS1ZJNmc9PSxpPTQwOTY=</challenge>

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NXVLSlVDb3BJSGc0dGFZVVVjYXF5dWJDTDJYeGRsTWxIYjd1QjhwcixwPVlkSE54aWYzbkgrcEMwZnFNd2lDbmowWmU0YzBldlFWL3I2RWxQUU43Z0U9</response>

2019-11-24 18:27:11 | user :: user_8lttws0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1iRlg5a1U2RlZlelF6eUNITWp5WjFxelV4bytsR3ZqUGZMVEZ5WC9iQmhrPQ==</success>

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

2019-11-24 18:27:12 | user :: user_8lttws0030@localhost >> <iq xmlns="jabber:client" id="Lf2fYm3k06iNFOHpXgPIUWn" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-24 18:27:12 | user :: user_8lttws0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="80hQ2aLQ8DtqgRWeycBh29j" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 18:27:12 | user :: user_8lttws0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" to="user_8lttws0030@localhost/993927746-tigase-23" id="80hQ2aLQ8DtqgRWeycBh29j" type="result"/>

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

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

2019-11-24 18:27:12 | user :: user_8lttws0030@localhost/993927746-tigase-23 << <enabled xmlns="urn:xmpp:sm:3" resume="true" max="60" location="d4270859fb27" id="9a9b8feb-2547-4dd9-bbf2-4358a74fe669"/>

2019-11-24 18:27:12 | user :: user_8lttws0030@localhost/993927746-tigase-23 >> <iq id="DZap8Ck5uqdDKU9woSQTRct" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:27:12 | user :: user_8lttws0030@localhost/993927746-tigase-23 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2019-11-24 18:27:12 | user :: user_8lttws0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" to="user_8lttws0030@localhost/993927746-tigase-23" id="DZap8Ck5uqdDKU9woSQTRct" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 18:27:12 | Disconnecting

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

2019-11-24 18:27:12 | [Mutex] notify: [disconnected]

2019-11-24 18:27:12 | [Mutex] received everything.

2019-11-24 18:27:14 | [Mutex] waiting for: [user]

2019-11-24 18:27:14 | [Mutex] received everything.

2019-11-24 18:27:14 | [Mutex] isItemNotified: user:ok:true :: true