Brute Force Prevention

Test duration: 15.080s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.218s
2019-11-22 18:26:35 |

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

2019-11-22 18:26:35 | ------------------------------------

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1e2c58fc

2019-11-22 18:26:35 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@289a09bc}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@10ebb549}, 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@14d4338c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@51d6bf72}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2dc1e60c}, 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=Fri Nov 22 18:26:35 PST 2019}}}}

2019-11-22 18:26:35 | [Mutex] waiting for: [registration]

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@60cd4f00

2019-11-22 18:26:35 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@10ebb549}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@14d4338c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@51d6bf72}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2dc1e60c}, 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=Fri Nov 22 18:26:35 PST 2019}}}}

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@553048c6

2019-11-22 18:26:35 | 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-22 18:26:35 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31f9403d}

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

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

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@13aa2188

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1995d9b2

2019-11-22 18:26:35 | 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-22 18:26:35 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4e34c43e}

2019-11-22 18:26:35 | 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-22 18:26:35 | user :: null >> <iq to="localhost" id="8sDCt5xtcCGDCeLJFDoYgDt" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 18:26:35 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a14c626d}

2019-11-22 18:26:35 | user :: null << <iq type="result" xmlns="jabber:client" from="localhost" id="8sDCt5xtcCGDCeLJFDoYgDt"><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-22 18:26:35 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@35b79d6d}

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@77535c32

2019-11-22 18:26:35 | user :: null >> <iq to="localhost" id="iLw0jPR1awmPR7JGs5Ep4k5" type="set"><query xmlns="jabber:iq:register"><username>user_8ainzf0027</username><password>user_8ainzf0027</password><email>8fa8a7c8-2b51-49c3-9d24-950290fb2154@localhost</email></query></iq>

2019-11-22 18:26:35 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@9968ce34}

2019-11-22 18:26:35 | user :: null << <iq type="result" xmlns="jabber:client" from="localhost" id="iLw0jPR1awmPR7JGs5Ep4k5"/>

2019-11-22 18:26:35 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@403c4323}

2019-11-22 18:26:35 | [Mutex] received everything.

2019-11-22 18:26:35 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 18:26:35 | 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;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31f9403d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4e34c43e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@10ebb549}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@14d4338c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@51d6bf72}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2dc1e60c}, 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=Fri Nov 22 18:26:35 PST 2019}}}}

2019-11-22 18:26:35 | 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;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31f9403d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4e34c43e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@10ebb549}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@14d4338c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@51d6bf72}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2dc1e60c}, 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=Fri Nov 22 18:26:35 PST 2019}}}}

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@28c16a2e

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2114d6ae

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4c4bac72

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6ecccb83

2019-11-22 18:26:35 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@4dff4c6e

2019-11-22 18:26:35 | user :: user_8ainzf0027@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-22 18:26:35 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1EV0R6a1gyYzBmNG5DeTU1S1FJaA==</auth>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EV0R6a1gyYzBmNG5DeTU1S1FJaDN4NGRXVjBCcGx6Y0gybzR3SW84LHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RFdEemtYMmMwZjRuQ3k1NUtRSWgzeDRkV1YwQnBsemNIMm80d0lvOCxwPWJtUVRPSWcyNXdsR2NDTlhUbjhlSno3VkgzZThGdTg3ZFQyaWFSUGxBUmM9</response>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1jVEU1cU95WXFsbWYrcml1MDRKc3k3cFhZbjl2OFhzSzR1MGgxak5MaTZBPQ==</success>

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

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost >> <iq xmlns="jabber:client" id="UyRS4fHN5oSVkLMKVQKSZ7B" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost/993927746-tigase-19 << <iq type="result" to="user_8ainzf0027@localhost/993927746-tigase-19" xmlns="jabber:client" id="eHgIS1oMRV3pW4s1fThMEtq"/>

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

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

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost/993927746-tigase-19 << <enabled resume="true" max="60" xmlns="urn:xmpp:sm:3" location="d4270859fb27" id="0a3a69a8-1081-41c3-ae45-0f60036c7e48"/>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost/993927746-tigase-19 >> <iq id="zARW4z8k2jLTbCsmZkEBp1l" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost/993927746-tigase-19 << <iq type="result" to="user_8ainzf0027@localhost/993927746-tigase-19" xmlns="jabber:client" id="zARW4z8k2jLTbCsmZkEBp1l"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 18:26:36 | Disconnecting

2019-11-22 18:26:36 | [Mutex] notify: [disconnected]

2019-11-22 18:26:36 | [Mutex] received everything.

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

2019-11-22 18:26:36 | [Mutex] waiting for: [event]

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1PQm1ZN28xcEh1ZThKeWNXdG5WeA==</auth>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PQm1ZN28xcEh1ZThKeWNXdG5WeGtJOFpIRzBBdlVqc0FUbkNldklWLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T0JtWTdvMXBIdWU4SnljV3RuVnhrSThaSEcwQXZVanNBVG5DZXZJVixwPWlUblo4MG5FTklTY080eXVBcWJYUEIwWlRVQ0ZoMjUraHVzQnU1QW4xUVE9</response>

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

2019-11-22 18:26:36 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:36 | [Mutex] received everything.

2019-11-22 18:26:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:36 | [Mutex] waiting for: [event]

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj11N01PNjFpOEJMVFI5WHBDanJDUw==</auth>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11N01PNjFpOEJMVFI5WHBDanJDU0pURHNWQ1FtMXJpM3dpY2ZUUnM1LHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dTdNTzYxaThCTFRSOVhwQ2pyQ1NKVERzVkNRbTFyaTN3aWNmVFJzNSxwPW1IOEZJOXM4TVYzYWVTZS9tdHBRcmpWS3UyeklVZlM4WThjZjV1V0tHWDQ9</response>

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

2019-11-22 18:26:36 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:36 | [Mutex] received everything.

2019-11-22 18:26:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:36 | [Mutex] waiting for: [event]

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1TYUh0MkRxaFpTd0hIOGFFdVRFOA==</auth>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TYUh0MkRxaFpTd0hIOGFFdVRFOGQxN0VMY2F0SkIxa3NkS1YxbXJFLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U2FIdDJEcWhaU3dISDhhRXVURThkMTdFTGNhdEpCMWtzZEtWMW1yRSxwPWdYZ3RyQXBSQUk1TG5sVWhKeXhNVXZlbGR3aTkzbk5JSFhYWWtYMFVkNjg9</response>

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

2019-11-22 18:26:36 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:36 | [Mutex] received everything.

2019-11-22 18:26:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:36 | [Mutex] waiting for: [event]

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1JVkx0TWV2cTNLbUs2SFRqZGttTw==</auth>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JVkx0TWV2cTNLbUs2SFRqZGttT09pNFlzTmtRSENVTGlpb0hiallaLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SVZMdE1ldnEzS21LNkhUamRrbU9PaTRZc05rUUhDVUxpaW9IYmpZWixwPXhtU0w2Y3QwMnY4aGJJY2JCMUxxWDdMbTN0V2FYU3F1d1V6a0NIL0lyOU09</response>

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

2019-11-22 18:26:36 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:36 | [Mutex] received everything.

2019-11-22 18:26:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:36 | [Mutex] waiting for: [event]

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj03RmxZZkxabzhZYU5QTk9EaDc2MQ==</auth>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03RmxZZkxabzhZYU5QTk9EaDc2MUNSYXdkMzd6T2tMZVNEaHNIcmdFLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N0ZsWWZMWm84WWFOUE5PRGg3NjFDUmF3ZDM3ek9rTGVTRGhzSHJnRSxwPXNZT0RKMUlkUDUrdWlyaHorKzArdUNoajdUNUg0dG1RT09sWEk3R3V4Wk09</response>

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

2019-11-22 18:26:36 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:36 | [Mutex] received everything.

2019-11-22 18:26:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:36 | [Mutex] waiting for: [event]

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1ldWlpZVVuUUxHbkJpemJIOWxPOA==</auth>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ldWlpZVVuUUxHbkJpemJIOWxPODlZRTRUUXVrYW5TSEZ2aExkRUp1LHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:36 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZXVpaWVVblFMR25CaXpiSDlsTzg5WUU0VFF1a2FuU0hGdmhMZEVKdSxwPVVEcjhzZCtsaGZNeFNhaXd1UUVDMDNLWHZUMDFrNkl0cndFMWRxZ2I2K0k9</response>

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

2019-11-22 18:26:36 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:36 | [Mutex] received everything.

2019-11-22 18:26:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:36 | [Mutex] waiting for: [event]

2019-11-22 18:26:36 | user :: user_8ainzf0027@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-22 18:26:36 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj01d01hSjNFVDdnQ3hPSWFoTWlyTg==</auth>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01d01hSjNFVDdnQ3hPSWFoTWlyTmt4c1luOTF4c1cySDVna0toMU1LLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NXdNYUozRVQ3Z0N4T0lhaE1pck5reHNZbjkxeHNXMkg1Z2tLaDFNSyxwPXZoc2dWNkEyeHFlSmlpbHZpZytJMFVSZUNkaG5JYXpFZ25uTVpydDY3cm89</response>

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

2019-11-22 18:26:37 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:37 | [Mutex] received everything.

2019-11-22 18:26:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:37 | [Mutex] waiting for: [event]

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj11Z0Z6Q0x2V3FPZ2VNTjZmeEFtMw==</auth>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11Z0Z6Q0x2V3FPZ2VNTjZmeEFtMzFOemNCWlRaUDhRMTFwS3hXSmpaLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWdGekNMdldxT2dlTU42ZnhBbTMxTnpjQlpUWlA4UTExcEt4V0pqWixwPWlFM3BrSGY1czRYbUxycDdmU2c5QUhLeHpSNjlkWGw0eDJsT3NnaEx1ZXM9</response>

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

2019-11-22 18:26:37 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:37 | [Mutex] received everything.

2019-11-22 18:26:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:37 | [Mutex] waiting for: [event]

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj11VzRJU1VROTN0elZzYXZhVmZSSw==</auth>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11VzRJU1VROTN0elZzYXZhVmZSS0NHdmFmU2t2dGNLTnBVNW9qbXpILHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dVc0SVNVUTkzdHpWc2F2YVZmUktDR3ZhZlNrdnRjS05wVTVvam16SCxwPVFsL3Brb0Nac084MmtvS0pjTmJBSlVnVXNTQ0lHNmMrQ2tGZzJpeTgySDA9</response>

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

2019-11-22 18:26:37 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:37 | [Mutex] received everything.

2019-11-22 18:26:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:37 | [Mutex] waiting for: [event]

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj00WVVFbFZLS0pvcTJreHB1eW9BVQ==</auth>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00WVVFbFZLS0pvcTJreHB1eW9BVXEzZk9HOHBXejJYZUt2M0NuandpLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NFlVRWxWS0tKb3Eya3hwdXlvQVVxM2ZPRzhwV3oyWGVLdjNDbmp3aSxwPS80bmp3Rzc4cDdSOU55S1RTemNXc0hWYlFuY0xiQ0QxNHdzYi9lM3c5Q1k9</response>

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

2019-11-22 18:26:37 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:37 | [Mutex] received everything.

2019-11-22 18:26:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:37 | [Mutex] waiting for: [event]

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1NbUg1c3ZRZGU2ckRtWEhJNWNWQw==</auth>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NbUg1c3ZRZGU2ckRtWEhJNWNWQ05wZ1NYRGpDc3FrNXFNZlNJd2M3LHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TW1INXN2UWRlNnJEbVhISTVjVkNOcGdTWERqQ3NxazVxTWZTSXdjNyxwPWZHVlMzS2REbk5tblNXZDBsTUVqSzVRNHE1S0ZoWW9HK2VrVUZGZVlwSjg9</response>

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

2019-11-22 18:26:37 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:37 | [Mutex] received everything.

2019-11-22 18:26:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:37 | [Mutex] waiting for: [event]

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj10VURwbHF3R0NzTnZ2NkpmcThSOA==</auth>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10VURwbHF3R0NzTnZ2NkpmcThSOFNOUVA4NEliWU8xQUhKSG82U01QLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFVEcGxxd0dDc052djZKZnE4UjhTTlFQODRJYllPMUFISkhvNlNNUCxwPUJTMk9TVFA3bFprK3NIYW5ZN0gxcDJ3dVpYemk3WVhuczBmdWhEc2FTUG89</response>

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

2019-11-22 18:26:37 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:37 | [Mutex] received everything.

2019-11-22 18:26:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:37 | [Mutex] waiting for: [event]

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj11c05OOUsxQWt6bUtoZmdJUjJkWA==</auth>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11c05OOUsxQWt6bUtoZmdJUjJkWG56WXVsUEtBamZiaEVpRXAxbzg0LHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dXNOTjlLMUFrem1LaGZnSVIyZFhuell1bFBLQWpmYmhFaUVwMW84NCxwPXZ1a2dFVTBSZ28wY3hkb2hOWlg3RHVlYk9sZ1lMcHc2cGI2Sk4wbGdaZEk9</response>

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

2019-11-22 18:26:37 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:37 | [Mutex] received everything.

2019-11-22 18:26:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:37 | [Mutex] waiting for: [event]

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1LNjVjbU16NHVQY2JiVjBNdXREWg==</auth>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LNjVjbU16NHVQY2JiVjBNdXREWjlLQjAwenZCdnJWNkJVWHRjV2FBLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SzY1Y21NejR1UGNiYlYwTXV0RFo5S0IwMHp2QnZyVjZCVVh0Y1dhQSxwPVNyLytEajNhWjV5TS9sT0FteVBHMkl3bkYyNTNSRnM0YW9lZFlBSEp0bGc9</response>

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

2019-11-22 18:26:37 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:37 | [Mutex] received everything.

2019-11-22 18:26:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:37 | [Mutex] waiting for: [event]

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj0wNWRQMW5SUzAzdDM3a3hQSUowSQ==</auth>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wNWRQMW5SUzAzdDM3a3hQSUowSXFqOEFVeEJZMlBQMW81cm03ODJCLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:37 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MDVkUDFuUlMwM3QzN2t4UElKMElxajhBVXhCWTJQUDFvNXJtNzgyQixwPTlWUmZKU0NTUlVGcEJoekZzUEJ1MTJWMFBMb25Qc2R3WllZWmdWTitBMVU9</response>

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

2019-11-22 18:26:37 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:37 | [Mutex] received everything.

2019-11-22 18:26:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:37 | [Mutex] notify: [event, disconnected]

2019-11-22 18:26:37 | [Mutex] waiting for: [event]

2019-11-22 18:26:37 | user :: user_8ainzf0027@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-22 18:26:37 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj15SXBheHNPSHJDaWlBeUp6MlZTSw==</auth>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15SXBheHNPSHJDaWlBeUp6MlZTS01URXp4UnM1TkFJQWNnSnFMY1MzLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eUlwYXhzT0hyQ2lpQXlKejJWU0tNVEV6eFJzNU5BSUFjZ0pxTGNTMyxwPVByYlRuenBrL1V1KzRRRmZmZWUreGRIcG9uSE9SbWY3dm9VdjdpcFZKV2s9</response>

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

2019-11-22 18:26:38 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:38 | [Mutex] notify: [event, disconnected]

2019-11-22 18:26:38 | [Mutex] received everything.

2019-11-22 18:26:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:38 | [Mutex] waiting for: [event]

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj05M2pXM244MkdrS0ZNd1QybEl0MQ==</auth>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05M2pXM244MkdrS0ZNd1QybEl0MXBkRVlIaUp6dGl0cllqOXBTSUNyLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OTNqVzNuODJHa0tGTXdUMmxJdDFwZEVZSGlKenRpdHJZajlwU0lDcixwPUp0cDNqSmwvVnlNSzhTM1cvMVlmdVErMWZZTmV5YkUwdVc3bDRkclZ1WjQ9</response>

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

2019-11-22 18:26:38 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:38 | [Mutex] received everything.

2019-11-22 18:26:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:38 | [Mutex] waiting for: [event]

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1iYUJjWVAwSHcxcjUyb2tibjFKSw==</auth>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iYUJjWVAwSHcxcjUyb2tibjFKS1pIS1JQaTBYeUUyd0F1T3Y1ZXhMLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YmFCY1lQMEh3MXI1Mm9rYm4xSktaSEtSUGkwWHlFMndBdU92NWV4TCxwPTZZcXpReDduY1A4aEhQdSthTlo2aUphd01OcTVzMGF0RkFCZ1dRSGZVbEE9</response>

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

2019-11-22 18:26:38 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:38 | [Mutex] received everything.

2019-11-22 18:26:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:38 | [Mutex] waiting for: [event]

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1Qa3NWbktITjdma0F1REUyZ2M1cA==</auth>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Qa3NWbktITjdma0F1REUyZ2M1cDRlZklsd0k5N3FBa1FOWGYxZmlpLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UGtzVm5LSE43ZmtBdURFMmdjNXA0ZWZJbHdJOTdxQWtRTlhmMWZpaSxwPVhtbGRuOHZuS2dUNDU5aDNvdVFQL2xmR0M3Q2xjMU9PakxZeDRsYXNYNzg9</response>

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

2019-11-22 18:26:38 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:38 | [Mutex] notify: [event, disconnected]

2019-11-22 18:26:38 | [Mutex] received everything.

2019-11-22 18:26:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:38 | [Mutex] waiting for: [event]

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1Jem1Bd1JUQXpybG1CNzNQRnJtUw==</auth>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Jem1Bd1JUQXpybG1CNzNQRnJtU3R1R3lDbTZFYUFsczhhcjNpZndlLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SXptQXdSVEF6cmxtQjczUEZybVN0dUd5Q202RWFBbHM4YXIzaWZ3ZSxwPSthZ1VEc3h4eFh0L2s0YUVmNDhhVEtCaTU0WTE2V2FzUXBaL0JyWVJzNU09</response>

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

2019-11-22 18:26:38 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:38 | [Mutex] received everything.

2019-11-22 18:26:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:38 | [Mutex] waiting for: [event]

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj12UmYwZ0NZRno2dmJBYTJMUUhuNg==</auth>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12UmYwZ0NZRno2dmJBYTJMUUhuNkFoTlpFTXdpTFJjTjhHN1dKeUY0LHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dlJmMGdDWUZ6NnZiQWEyTFFIbjZBaE5aRU13aUxSY044RzdXSnlGNCxwPVJUZWsxMkkvei8wNUllbUlsWnplUUdhbXdORWx0U1VNODMwK0NDTUlITlk9</response>

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

2019-11-22 18:26:38 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:38 | [Mutex] received everything.

2019-11-22 18:26:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:38 | user :: user_8ainzf0027@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-22 18:26:38 | user :: user_8ainzf0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhhaW56ZjAwMjcscj1Cd0tYb0Fxc1MxS0Z2M0JmTXpCUg==</auth>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Cd0tYb0Fxc1MxS0Z2M0JmTXpCUmF2M1NCNVRTakpFclBzbDNXS3ZYLHM9Tkt4T09RMEg0dVFLTkE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:38 | user :: user_8ainzf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QndLWG9BcXNTMUtGdjNCZk16QlJhdjNTQjVUU2pKRXJQc2wzV0t2WCxwPWhqZlNMY1JjT212S1puVDlzOW90dUEyK2JmSmd5ZWNYT0xRc0JCdE90aG89</response>

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

2019-11-22 18:26:40 | [Mutex] waiting for: [user]

2019-11-22 18:26:40 | [Mutex] received everything.

2019-11-22 18:26:40 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.376s
2019-11-22 18:26:40 |

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

2019-11-22 18:26:40 | ------------------------------------

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@645c9afc

2019-11-22 18:26:41 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@289a09bc}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a9b7807}, 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@6ea4f18c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2ba6723c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b2d86ce}, 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=Fri Nov 22 18:26:41 PST 2019}}}}

2019-11-22 18:26:41 | [Mutex] waiting for: [registration]

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1ac798ec

2019-11-22 18:26:41 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a9b7807}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@6ea4f18c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2ba6723c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b2d86ce}, 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=Fri Nov 22 18:26:41 PST 2019}}}}

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@53a632a9

2019-11-22 18:26:41 | 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-22 18:26:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4b898d73}

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

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

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@cd5793a

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2a7390b4

2019-11-22 18:26:41 | 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-22 18:26:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@48a2dc29}

2019-11-22 18:26:41 | 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-22 18:26:41 | user :: null >> <iq to="localhost" id="CXSIumX3tlW6EzuYfHBv8se" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 18:26:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@fd7084e2}

2019-11-22 18:26:41 | user :: null << <iq type="result" xmlns="jabber:client" from="localhost" id="CXSIumX3tlW6EzuYfHBv8se"><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-22 18:26:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4fc7325b}

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@68fc8e30

2019-11-22 18:26:41 | user :: null >> <iq to="localhost" id="EBMU3fR7ucQXgwlTZhGyqX7" type="set"><query xmlns="jabber:iq:register"><username>user_w7om9h0028</username><password>user_w7om9h0028</password><email>511b397c-5ead-4070-b3f4-3d3ef06bccea@localhost</email></query></iq>

2019-11-22 18:26:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@19e6763f}

2019-11-22 18:26:41 | user :: null << <iq type="result" xmlns="jabber:client" from="localhost" id="EBMU3fR7ucQXgwlTZhGyqX7"/>

2019-11-22 18:26:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5ebc45ab}

2019-11-22 18:26:41 | [Mutex] received everything.

2019-11-22 18:26:41 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 18:26:41 | 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;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4b898d73, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@48a2dc29]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a9b7807}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@6ea4f18c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2ba6723c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b2d86ce}, 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=Fri Nov 22 18:26:41 PST 2019}}}}

2019-11-22 18:26:41 | 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;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4b898d73, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@48a2dc29]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a9b7807}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@6ea4f18c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2ba6723c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b2d86ce}, 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=Fri Nov 22 18:26:41 PST 2019}}}}

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2189c1

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@76023674

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7a03bb8a

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@46ae287c

2019-11-22 18:26:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4acddee9

2019-11-22 18:26:41 | user :: user_w7om9h0028@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-22 18:26:41 | user :: user_w7om9h0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:41 | user :: user_w7om9h0028@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-22 18:26:41 | user :: user_w7om9h0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3c3b205aDAwMjgscj16SWx4YTcxa0QxckdkWURPeHN2dg==</auth>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16SWx4YTcxa0QxckdkWURPeHN2dnpiZFVBS1JYWHZaQkNSeklBb0hVLHM9MWczTjF3NmdsQWhDUFE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eklseGE3MWtEMXJHZFlET3hzdnZ6YmRVQUtSWFh2WkJDUnpJQW9IVSxwPXlWa0NFQnB4WnVsVUNqSVBHVyt6aUhTWGVyMnRJOWs1RUpQYTlMV0RkZjA9</response>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1lcUtHM3BOVVVRbjVNR3RDcDJPLzh2blVHSzZlelhPcGxDdTJLeDNsNkxZPQ==</success>

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

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost >> <iq xmlns="jabber:client" id="3FW6odqUcDpbLMM0hUOV3jV" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost << <iq type="result" to="user_w7om9h0028@localhost/993927746-tigase-20" xmlns="jabber:client" id="3FW6odqUcDpbLMM0hUOV3jV"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_w7om9h0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="DzCgU3fR7ucQXgwlTZhGyqX" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost/993927746-tigase-20 << <iq type="result" to="user_w7om9h0028@localhost/993927746-tigase-20" xmlns="jabber:client" id="DzCgU3fR7ucQXgwlTZhGyqX"/>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="XHY7DLKAlar8slGqeHxrhOQ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost/993927746-tigase-20 << <enabled resume="true" max="60" xmlns="urn:xmpp:sm:3" location="d4270859fb27" id="d86e0d72-eec1-4d96-85e9-c64a6f20289c"/>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost/993927746-tigase-20 >> <iq id="Z0RbAgHSRY8HoQ4nT9HEwuf" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost/993927746-tigase-20 << <iq type="result" to="user_w7om9h0028@localhost/993927746-tigase-20" xmlns="jabber:client" id="Z0RbAgHSRY8HoQ4nT9HEwuf"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 18:26:41 | Disconnecting

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

2019-11-22 18:26:41 | [Mutex] notify: [disconnected]

2019-11-22 18:26:41 | [Mutex] received everything.

2019-11-22 18:26:41 | [Mutex] waiting for: [event]

2019-11-22 18:26:41 | user :: user_w7om9h0028@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-22 18:26:41 | user :: user_w7om9h0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:41 | user :: user_w7om9h0028@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-22 18:26:41 | user :: user_w7om9h0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3c3b205aDAwMjgscj1mbmcyendYQVFyekVSeWs3bzU3aw==</auth>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mbmcyendYQVFyekVSeWs3bzU3a1BsWGtZRHNwRFJvcFhhbFpNaFE5LHM9MWczTjF3NmdsQWhDUFE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Zm5nMnp3WEFRcnpFUnlrN281N2tQbFhrWURzcERSb3BYYWxaTWhROSxwPVVhNGRzODEzNjg4REpxWXVpR0s4Qjk3OGFwZ2E2aXhtdVEzREZ2amlXVGM9</response>

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

2019-11-22 18:26:41 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:41 | [Mutex] notify: [event, disconnected]

2019-11-22 18:26:41 | [Mutex] received everything.

2019-11-22 18:26:41 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:41 | [Mutex] waiting for: [event]

2019-11-22 18:26:41 | user :: user_w7om9h0028@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-22 18:26:41 | user :: user_w7om9h0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:41 | user :: user_w7om9h0028@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-22 18:26:41 | user :: user_w7om9h0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3c3b205aDAwMjgscj12UkduM21iSmZYMElWbENYZVZRSA==</auth>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12UkduM21iSmZYMElWbENYZVZRSHZrZkwxSDN3NmVWekJ2a1FXaUxTLHM9MWczTjF3NmdsQWhDUFE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dlJHbjNtYkpmWDBJVmxDWGVWUUh2a2ZMMUgzdzZlVnpCdmtRV2lMUyxwPXRVbVhjOUE3VGgxL2FiMkNma3U0bUFabCtpR3BaSmJ3VmtCUlA2cVNwL1E9</response>

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

2019-11-22 18:26:41 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:41 | [Mutex] notify: [event, disconnected]

2019-11-22 18:26:41 | [Mutex] received everything.

2019-11-22 18:26:41 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:41 | [Mutex] waiting for: [event]

2019-11-22 18:26:41 | user :: user_w7om9h0028@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-22 18:26:41 | user :: user_w7om9h0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:41 | user :: user_w7om9h0028@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-22 18:26:41 | user :: user_w7om9h0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3c3b205aDAwMjgscj1YZmVrdGF0MlFjOUdreWhyNmN4Zg==</auth>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YZmVrdGF0MlFjOUdreWhyNmN4ZmcwM2Z2VllLZnNmcHE3QUJMc25FLHM9MWczTjF3NmdsQWhDUFE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:41 | user :: user_w7om9h0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WGZla3RhdDJRYzlHa3locjZjeGZnMDNmdlZZS2ZzZnBxN0FCTHNuRSxwPXRXQUZxZ1BTQjJTUnhJWlQ3S29iVjF2MktZazNjamxNVDZVUGgvSktKWEk9</response>

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

2019-11-22 18:26:41 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:41 | [Mutex] received everything.

2019-11-22 18:26:41 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:42 | [Mutex] waiting for: [event]

2019-11-22 18:26:42 | user :: user_w7om9h0028@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-22 18:26:42 | user :: user_w7om9h0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:42 | user :: user_w7om9h0028@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-22 18:26:42 | user :: user_w7om9h0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3c3b205aDAwMjgscj1uTDRla0JPeVBKRTdDaVFCSzNvRA==</auth>

2019-11-22 18:26:42 | user :: user_w7om9h0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uTDRla0JPeVBKRTdDaVFCSzNvRHJNWHo4T1JKYVVRYVVjdHNFVDViLHM9MWczTjF3NmdsQWhDUFE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:42 | user :: user_w7om9h0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bkw0ZWtCT3lQSkU3Q2lRQkszb0RyTVh6OE9SSmFVUWFVY3RzRVQ1YixwPUc4SitNSVhHSU5TR3J4L3J0WjFBOXRRMTR3NW8ydkdBZDBFd0g2ZHNRZlE9</response>

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

2019-11-22 18:26:42 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:42 | [Mutex] notify: [event, disconnected]

2019-11-22 18:26:42 | [Mutex] received everything.

2019-11-22 18:26:42 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:42 | user :: user_w7om9h0028@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-22 18:26:42 | user :: user_w7om9h0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:42 | user :: user_w7om9h0028@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-22 18:26:42 | user :: user_w7om9h0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3c3b205aDAwMjgscj1WaVk5bGt6MmtuRlQ2WE8zOFFidg==</auth>

2019-11-22 18:26:42 | user :: user_w7om9h0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WaVk5bGt6MmtuRlQ2WE8zOFFidm9UU1IxNmdmZDBPYWRQSHJHSDVWLHM9MWczTjF3NmdsQWhDUFE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:42 | user :: user_w7om9h0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VmlZOWxrejJrbkZUNlhPMzhRYnZvVFNSMTZnZmQwT2FkUEhyR0g1VixwPWpXTXVtdGRGRXBPdW4wbEZCK0x0ZEk3bnFYbUgwVGdtYUdUNS9kbDlaOWM9</response>

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

2019-11-22 18:26:44 | [Mutex] waiting for: [user]

2019-11-22 18:26:44 | [Mutex] received everything.

2019-11-22 18:26:44 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.194s
2019-11-22 18:26:44 |

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

2019-11-22 18:26:44 | ------------------------------------

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@64b0ee1f

2019-11-22 18:26:44 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@289a09bc}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a770cf9}, 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@6e48856f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2b4a06c2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@48e9d5a2}, 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=Fri Nov 22 18:26:44 PST 2019}}}}

2019-11-22 18:26:44 | [Mutex] waiting for: [registration]

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1a2b0882

2019-11-22 18:26:44 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a770cf9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@6e48856f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2b4a06c2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@48e9d5a2}, 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=Fri Nov 22 18:26:44 PST 2019}}}}

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@30628555

2019-11-22 18:26:44 | 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-22 18:26:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4b65f98d}

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

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

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4d276186

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@f8a0fb8

2019-11-22 18:26:44 | 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-22 18:26:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2b666b31}

2019-11-22 18:26:44 | 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-22 18:26:44 | user :: null >> <iq to="localhost" id="5QhXUS8v9FJIEKLSKNNNTU0" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 18:26:44 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@bcbaee9d}

2019-11-22 18:26:44 | user :: null << <iq type="result" xmlns="jabber:client" from="localhost" id="5QhXUS8v9FJIEKLSKNNNTU0"><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-22 18:26:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4f2b4641}

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@39f63573

2019-11-22 18:26:44 | user :: null >> <iq to="localhost" id="XM3hXp2avu5q2v04whHLV6q" type="set"><query xmlns="jabber:iq:register"><username>user_efqgdt0029</username><password>user_efqgdt0029</password><email>b29eb174-849f-466f-93c3-4d458fd07ac2@localhost</email></query></iq>

2019-11-22 18:26:44 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2dc3e953}

2019-11-22 18:26:44 | [Mutex] received everything.

2019-11-22 18:26:44 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 18:26:44 | user :: null << <iq type="result" xmlns="jabber:client" from="localhost" id="XM3hXp2avu5q2v04whHLV6q"/>

2019-11-22 18:26:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@665e1a3a}

2019-11-22 18:26:44 | 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;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4b65f98d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2b666b31]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a770cf9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@6e48856f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2b4a06c2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@48e9d5a2}, 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=Fri Nov 22 18:26:44 PST 2019}}}}

2019-11-22 18:26:44 | 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;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4b65f98d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2b666b31]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a770cf9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@6e48856f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2b4a06c2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@48e9d5a2}, 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=Fri Nov 22 18:26:44 PST 2019}}}}

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7ef9da23

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6bf582f3

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@63a07f53

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@753936d7

2019-11-22 18:26:44 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@45a1d291

2019-11-22 18:26:44 | user :: user_efqgdt0029@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-22 18:26:44 | user :: user_efqgdt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:44 | user :: user_efqgdt0029@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-22 18:26:44 | user :: user_efqgdt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2VmcWdkdDAwMjkscj1mYzJjNEtLUkM1WnZ2ekJ0THAwZA==</auth>

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mYzJjNEtLUkM1WnZ2ekJ0THAwZHgxUlQ3bjNuSnc2enExMHZWc1FQLHM9V2kxYWV5WmxraUlJMUE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZmMyYzRLS1JDNVp2dnpCdExwMGR4MVJUN24zbkp3NnpxMTB2VnNRUCxwPTMvVWI1WE1RVkliL0RLemtHNVZhUmpQNEJYck5sVGxpQllVRWZYS3JCaEU9</response>

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1qQ3huUGZndnFVVWFtOGpIOC9GVFpRQ2U5V3gzRWVJQWFFcmFHY0RLZDI4PQ==</success>

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

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost >> <iq xmlns="jabber:client" id="YTm5FyczClW4z8k2jLTbCsm" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost << <iq type="result" to="user_efqgdt0029@localhost/993927746-tigase-21" xmlns="jabber:client" id="YTm5FyczClW4z8k2jLTbCsm"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_efqgdt0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="wN2dUV6odqUcDpbLMM0hUOV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost/993927746-tigase-21 << <iq type="result" to="user_efqgdt0029@localhost/993927746-tigase-21" xmlns="jabber:client" id="wN2dUV6odqUcDpbLMM0hUOV"/>

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="Z7Yp2avu5q2v04whHLV6qiR" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost/993927746-tigase-21 << <enabled resume="true" max="60" xmlns="urn:xmpp:sm:3" location="d4270859fb27" id="6d4030bf-a25d-46f1-8353-4a008b0f2650"/>

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost/993927746-tigase-21 >> <iq id="wP4h2bCqhyaIFtj1iO4pakX" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 18:26:44 | user :: user_efqgdt0029@localhost/993927746-tigase-21 << <iq type="result" to="user_efqgdt0029@localhost/993927746-tigase-21" xmlns="jabber:client" id="wP4h2bCqhyaIFtj1iO4pakX"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 18:26:44 | Disconnecting

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

2019-11-22 18:26:44 | [Mutex] notify: [disconnected]

2019-11-22 18:26:44 | [Mutex] received everything.

2019-11-22 18:26:44 | [Mutex] waiting for: [event]

2019-11-22 18:26:44 | user :: user_efqgdt0029@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-22 18:26:44 | user :: user_efqgdt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:44 | user :: user_efqgdt0029@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-22 18:26:45 | user :: user_efqgdt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2VmcWdkdDAwMjkscj15dVNPMm9rMzdhWWhJTlVzMjBBUQ==</auth>

2019-11-22 18:26:45 | user :: user_efqgdt0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15dVNPMm9rMzdhWWhJTlVzMjBBUVRyOTdzbUVLdzBidjRmRlZnajFYLHM9aEU3RmI5TUxESjNkeUE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:45 | user :: user_efqgdt0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eXVTTzJvazM3YVloSU5VczIwQVFUcjk3c21FS3cwYnY0ZkZWZ2oxWCxwPWVuenpGRGhEczVlT1N4L0dROW83QTFvSUI4OD0=</response>

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

2019-11-22 18:26:45 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:45 | [Mutex] received everything.

2019-11-22 18:26:45 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:45 | [Mutex] waiting for: [event]

2019-11-22 18:26:45 | user :: user_efqgdt0029@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-22 18:26:45 | user :: user_efqgdt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:45 | user :: user_efqgdt0029@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-22 18:26:45 | user :: user_efqgdt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfZWZxZ2R0MDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-22 18:26:45 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:45 | [Mutex] received everything.

2019-11-22 18:26:45 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:45 | [Mutex] waiting for: [event]

2019-11-22 18:26:45 | user :: user_efqgdt0029@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-22 18:26:45 | user :: user_efqgdt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:45 | user :: user_efqgdt0029@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-22 18:26:45 | user :: user_efqgdt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2VmcWdkdDAwMjkscj1SdWJ6UVRyYW8ydFI2TE9Ddzl6Vg==</auth>

2019-11-22 18:26:45 | user :: user_efqgdt0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SdWJ6UVRyYW8ydFI2TE9Ddzl6VmhKYkZGMHMzVkx0TkJ5OUZ6TVF2LHM9aEU3RmI5TUxESjNkeUE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:45 | user :: user_efqgdt0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UnVielFUcmFvMnRSNkxPQ3c5elZoSmJGRjBzM1ZMdE5CeTlGek1RdixwPXVMKzJ3aFlMNGYreVJhczJqT3hEMDNwd2hncz0=</response>

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

2019-11-22 18:26:45 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:45 | [Mutex] received everything.

2019-11-22 18:26:45 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:45 | [Mutex] waiting for: [event]

2019-11-22 18:26:45 | user :: user_efqgdt0029@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-22 18:26:45 | user :: user_efqgdt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:45 | user :: user_efqgdt0029@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-22 18:26:45 | user :: user_efqgdt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2VmcWdkdDAwMjkscj11Um40NHd0d3RuUjBMSTRiMEVZNw==</auth>

2019-11-22 18:26:45 | user :: user_efqgdt0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11Um40NHd0d3RuUjBMSTRiMEVZN3ZwT3psd3E0WTQ5MHJ5WEhRS3NMLHM9V2kxYWV5WmxraUlJMUE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:45 | user :: user_efqgdt0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dVJuNDR3dHd0blIwTEk0YjBFWTd2cE96bHdxNFk0OTByeVhIUUtzTCxwPUJWREgrTC90UldVdnhtK2JhL25Ua2d4T281aE93N3kzQVVPOWNXclE3WVU9</response>

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

2019-11-22 18:26:45 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:45 | [Mutex] received everything.

2019-11-22 18:26:45 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:45 | user :: user_efqgdt0029@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-22 18:26:45 | user :: user_efqgdt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:45 | user :: user_efqgdt0029@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-22 18:26:45 | user :: user_efqgdt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2VmcWdkdDAwMjkscj1vVWM0Tkg5N0dTV1kwcVhnYnZ3VA==</auth>

2019-11-22 18:26:45 | user :: user_efqgdt0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vVWM0Tkg5N0dTV1kwcVhnYnZ3VEdhUDR0SHBGc0ZNZ1BKVWNJS1BILHM9V2kxYWV5WmxraUlJMUE9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:45 | user :: user_efqgdt0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b1VjNE5IOTdHU1dZMHFYZ2J2d1RHYVA0dEhwRnNGTWdQSlVjSUtQSCxwPTB2Q2IvVFR2Z0JNdWw2NFU2UXpuUzYzZDJxbG8wbnc5Q0RLRUdUcWU4ck09</response>

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

2019-11-22 18:26:47 | [Mutex] waiting for: [user]

2019-11-22 18:26:47 | [Mutex] received everything.

2019-11-22 18:26:47 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.019s
2019-11-22 18:26:47 |

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

2019-11-22 18:26:47 | ------------------------------------

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4055ed0c

2019-11-22 18:26:47 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@289a09bc}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4e921b76}, 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@4aad867c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@faf114d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@607db039}, 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=Fri Nov 22 18:26:47 PST 2019}}}}

2019-11-22 18:26:47 | [Mutex] waiting for: [registration]

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3e6a5eeb

2019-11-22 18:26:47 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4e921b76}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@4aad867c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@faf114d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@607db039}, 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=Fri Nov 22 18:26:47 PST 2019}}}}

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@1852a13c

2019-11-22 18:26:47 | 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-22 18:26:47 | 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-22 18:26:47 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6f80ee02}

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

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

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@62f167b3

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@e00e000

2019-11-22 18:26:47 | 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-22 18:26:47 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@356ebbd}

2019-11-22 18:26:47 | 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-22 18:26:47 | user :: null >> <iq to="localhost" id="i8TKNNNTU0kLJRdEoXoT2gX" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 18:26:47 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@cd3e7044}

2019-11-22 18:26:47 | user :: null << <iq type="result" xmlns="jabber:client" from="localhost" id="i8TKNNNTU0kLJRdEoXoT2gX"><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-22 18:26:47 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6bcef52b}

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@26bdb1e

2019-11-22 18:26:47 | user :: null >> <iq to="localhost" id="UVeCydDFPSQRcvgIRIumX3t" type="set"><query xmlns="jabber:iq:register"><username>user_wguun80030</username><password>user_wguun80030</password><email>db501837-d60d-454f-a907-3bc9bab7b42e@localhost</email></query></iq>

2019-11-22 18:26:47 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6323801f}

2019-11-22 18:26:47 | [Mutex] received everything.

2019-11-22 18:26:47 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 18:26:47 | user :: null << <iq type="result" xmlns="jabber:client" from="localhost" id="UVeCydDFPSQRcvgIRIumX3t"/>

2019-11-22 18:26:47 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@be22bb3}

2019-11-22 18:26:47 | 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;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6f80ee02, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@356ebbd]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4e921b76}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@4aad867c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@faf114d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@607db039}, 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=Fri Nov 22 18:26:47 PST 2019}}}}

2019-11-22 18:26:47 | 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;@289a09bc}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6f80ee02, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@356ebbd]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4e921b76}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@353fa093}, 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@4aad867c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@faf114d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@607db039}, 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=Fri Nov 22 18:26:47 PST 2019}}}}

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3fdd2271

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2326ef0c

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7f49635d

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@65ec60b4

2019-11-22 18:26:47 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@33f408d2

2019-11-22 18:26:47 | user :: user_wguun80030@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-22 18:26:47 | user :: user_wguun80030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:26:47 | user :: user_wguun80030@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-22 18:26:47 | user :: user_wguun80030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dndXVuODAwMzAscj1tU1liNm5lMGNTamtDUlhUeGtWUw==</auth>

2019-11-22 18:26:47 | user :: user_wguun80030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tU1liNm5lMGNTamtDUlhUeGtWU0FvNjlybFJFWFp6aWs4WTFYN0VvLHM9UGJVK3A2S0lMNVdjWGc9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:47 | user :: user_wguun80030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bVNZYjZuZTBjU2prQ1JYVHhrVlNBbzY5cmxSRVhaemlrOFkxWDdFbyxwPUNhZUtMRUsxVDNSNFhxU2QzWG5HMXVtS0lKNWM0ditSMHhKa0VXZ2k2dms9</response>

2019-11-22 18:26:47 | user :: user_wguun80030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1lK2syM3JweU13M3MyZVJsZlE0R3JmYi9Ub0JPendoQ1FpNXQvdU0wRHBzPQ==</success>

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

2019-11-22 18:26:47 | user :: user_wguun80030@localhost >> <iq xmlns="jabber:client" id="h5GGm1fHHweMFxtr6iL07ua" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-22 18:26:47 | user :: user_wguun80030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="6gbkIORR5zo0sbIq9vdJAm2" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 18:26:47 | user :: user_wguun80030@localhost/993927746-tigase-22 << <iq type="result" to="user_wguun80030@localhost/993927746-tigase-22" xmlns="jabber:client" id="6gbkIORR5zo0sbIq9vdJAm2"/>

2019-11-22 18:26:47 | user :: user_wguun80030@localhost/993927746-tigase-22 >> <iq to="localhost" id="wWbvu5q2v04whHLV6qiR48z" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2019-11-22 18:26:47 | user :: user_wguun80030@localhost/993927746-tigase-22 << <enabled resume="true" max="60" xmlns="urn:xmpp:sm:3" location="d4270859fb27" id="d6137673-1ba4-4d1a-9cee-e688dcfd739f"/>

2019-11-22 18:26:47 | user :: user_wguun80030@localhost/993927746-tigase-22 >> <iq id="b0l1r8uq7AaDt9BkQ07rh3k" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 18:26:47 | user :: user_wguun80030@localhost/993927746-tigase-22 << <iq type="result" to="user_wguun80030@localhost/993927746-tigase-22" xmlns="jabber:client" id="b0l1r8uq7AaDt9BkQ07rh3k"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 18:26:47 | Disconnecting

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

2019-11-22 18:26:47 | [Mutex] notify: [disconnected]

2019-11-22 18:26:47 | [Mutex] received everything.

2019-11-22 18:26:48 | [Mutex] waiting for: [event]

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

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

2019-11-22 18:26:48 | user :: user_wguun80030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RNnhrV1VkSVY5VGhwdFhjdDcxa2xZNVkzQUpYMWptWExkM0JSR1JmLHM9UGJVK3A2S0lMNVdjWGc9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UTZ4a1dVZElWOVRocHRYY3Q3MWtsWTVZM0FKWDFqbVhMZDNCUkdSZixwPUJ0R2hXUyttcFFlN2JiTC9KVVl0K3FCWFA4UUYvZWtoa1I3QVdlc05oWGM9</response>

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

2019-11-22 18:26:48 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:48 | [Mutex] received everything.

2019-11-22 18:26:48 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:48 | [Mutex] waiting for: [event]

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

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

2019-11-22 18:26:48 | user :: user_wguun80030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13Qk9FQTB1M0p2Q05sUTFhQXN1T3Q1YlZzeVdrTUlCT05meElxVWRPLHM9UGJVK3A2S0lMNVdjWGc9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d0JPRUEwdTNKdkNObFExYUFzdU90NWJWc3lXa01JQk9OZnhJcVVkTyxwPTYwejE3ZHUrYUhhc3FFVzdia0dpbUVlSytJSktiN0dKdVQzUitsc050OHc9</response>

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

2019-11-22 18:26:48 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:48 | [Mutex] received everything.

2019-11-22 18:26:48 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:26:48 | [Mutex] waiting for: [event]

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

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

2019-11-22 18:26:48 | user :: user_wguun80030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zWklqS0dpTFRtR3B1alJhVmtDcTlsUWtkZ0hLNXQ2TFV5bHM1MGRHLHM9UGJVK3A2S0lMNVdjWGc9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M1pJaktHaUxUbUdwdWpSYVZrQ3E5bFFrZGdISzV0NkxVeWxzNTBkRyxwPXJpODZMeE9FWk12QTlkL0EvM1pwRk5aTFRUb3ZJL0hvR0JncytFL1F6bVk9</response>

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

2019-11-22 18:26:48 | [Mutex] notify: [event, authFailed]

2019-11-22 18:26:48 | [Mutex] received everything.

2019-11-22 18:26:48 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-22 18:26:48 | user :: user_wguun80030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yTHJVRFJ2cGFnaHd4NVlvZ0tmVFhhaHQzYk5XbHFQQlpqVGxWTW83LHM9UGJVK3A2S0lMNVdjWGc9PSxpPTQwOTY=</challenge>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MkxyVURSdnBhZ2h3eDVZb2dLZlRYYWh0M2JOV2xxUEJaalRsVk1vNyxwPSt0akFWaGI3NU5RNXJCbXJDNGc4VGtRTkpCYXdrMDcxK21mdVB0WVpjMmM9</response>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0yeHJCWDZidEJyNDlnemJGZUJWUXVQR1RhNy91ZFNmL3ZIQ0ZTbnVPdHpvPQ==</success>

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

2019-11-22 18:26:48 | user :: user_wguun80030@localhost >> <iq xmlns="jabber:client" id="Zh8JGs5Ep4k5aoazhVfKIS1" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost << <iq type="result" to="user_wguun80030@localhost/993927746-tigase-23" xmlns="jabber:client" id="Zh8JGs5Ep4k5aoazhVfKIS1"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_wguun80030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="wZeBGtcABcsiPNXjSYo3sU7" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost/993927746-tigase-23 << <iq type="result" to="user_wguun80030@localhost/993927746-tigase-23" xmlns="jabber:client" id="wZeBGtcABcsiPNXjSYo3sU7"/>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost/993927746-tigase-23 >> <iq to="localhost" id="6lgu2s9rfT2i2l24r5n3eEC" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost/993927746-tigase-23 << <enabled resume="true" max="60" xmlns="urn:xmpp:sm:3" location="d4270859fb27" id="c736458b-f4d1-4462-ab71-c2ab829cba51"/>

2019-11-22 18:26:48 | user :: user_wguun80030@localhost/993927746-tigase-23 >> <iq id="Y8BzDu4j6jSWjCiYbvn9yk6" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 18:26:48 | user :: user_wguun80030@localhost/993927746-tigase-23 << <iq type="result" to="user_wguun80030@localhost/993927746-tigase-23" xmlns="jabber:client" id="Y8BzDu4j6jSWjCiYbvn9yk6"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 18:26:48 | Disconnecting

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

2019-11-22 18:26:48 | [Mutex] notify: [disconnected]

2019-11-22 18:26:48 | [Mutex] received everything.

2019-11-22 18:26:50 | [Mutex] waiting for: [user]

2019-11-22 18:26:50 | [Mutex] received everything.

2019-11-22 18:26:50 | [Mutex] isItemNotified: user:ok:true :: true