Brute Force Prevention

2019-11-26 19:58:24 |

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

2019-11-26 19:58:24 | ------------------------------------

2019-11-26 19:58:24 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1f33bfde

2019-11-26 19:58:24 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6ed310ae}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@11f44248}, 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@15cbd4ae}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@50c94873}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5286d0fb}, 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=Tue Nov 26 19:58:24 PST 2019}}}}

2019-11-26 19:58:24 | [Mutex] waiting for: [registration]

2019-11-26 19:58:24 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@61533ee1

2019-11-26 19:58:24 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@11f44248}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@15cbd4ae}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@50c94873}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5286d0fb}, 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=Tue Nov 26 19:58:24 PST 2019}}}}

2019-11-26 19:58:24 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2af6f8c1

2019-11-26 19:58:24 | 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-26 19:58:24 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@30e6b73c}

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

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

2019-11-26 19:58:24 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5483b8d3

2019-11-26 19:58:24 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2cdf2094

2019-11-26 19:58:24 | 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-26 19:58:24 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31f2f53e}

2019-11-26 19:58:24 | 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-26 19:58:24 | user :: null >> <iq to="localhost" id="rSTTPEEGt4cqbFNZewm4rSP" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-26 19:58:24 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e1b00ec8}

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

2019-11-26 19:58:24 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@34a8eb6b}

2019-11-26 19:58:24 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@7da4980d

2019-11-26 19:58:24 | user :: null >> <iq to="localhost" id="atEAwlGr7BzoZ4AAbHIUXXU" type="set"><query xmlns="jabber:iq:register"><username>user_4u6ny90027</username><password>user_4u6ny90027</password><email>a8048ab6-d4c7-4bdf-ad37-cb7a89ef58eb@localhost</email></query></iq>

2019-11-26 19:58:24 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8c17dc4}

2019-11-26 19:58:25 | user :: null << <iq from="localhost" id="atEAwlGr7BzoZ4AAbHIUXXU" xmlns="jabber:client" type="result"/>

2019-11-26 19:58:25 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@282adcad}

2019-11-26 19:58:25 | [Mutex] received everything.

2019-11-26 19:58:25 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 19:58:25 | 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;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@30e6b73c, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31f2f53e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@11f44248}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@15cbd4ae}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@50c94873}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5286d0fb}, 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=Tue Nov 26 19:58:25 PST 2019}}}}

2019-11-26 19:58:25 | 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;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@30e6b73c, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31f2f53e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@11f44248}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@15cbd4ae}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@50c94873}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5286d0fb}, 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=Tue Nov 26 19:58:25 PST 2019}}}}

2019-11-26 19:58:25 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@e579793

2019-11-26 19:58:25 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7d57c681

2019-11-26 19:58:25 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@24ea5dd6

2019-11-26 19:58:25 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5adb3252

2019-11-26 19:58:25 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@6802dd95

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1BaTBJbzQzdWNXdjVsMXdjdXpMdw==</auth>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BaTBJbzQzdWNXdjVsMXdjdXpMdzhHblNNRFdFVDNCOVhUa2dVVVIzLHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QWkwSW80M3VjV3Y1bDF3Y3V6THc4R25TTURXRVQzQjlYVGtnVVVSMyxwPUlFUTFKR1hmelc5VkpEZm1vcDlJUmVabU9YTFBEWEtVTG1jaHRpcFRQMGc9</response>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1kTGdGUUpQZzRTcWdhOTJBMC95Rlg0TUk0V0NCNWVGOHp0VnlDMGQxRFJjPQ==</success>

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

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost >> <iq xmlns="jabber:client" id="eqtZdNXaxaMYXfO6lJsgUVY" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost << <iq id="eqtZdNXaxaMYXfO6lJsgUVY" xmlns="jabber:client" type="result" to="user_4u6ny90027@localhost/993927746-tigase-19"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_4u6ny90027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="HLseLw7tjZeFqi01n4CnNAw" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost/993927746-tigase-19 << <iq id="HLseLw7tjZeFqi01n4CnNAw" xmlns="jabber:client" type="result" to="user_4u6ny90027@localhost/993927746-tigase-19"/>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost/993927746-tigase-19 >> <iq to="localhost" id="fxKHLT2hEKUPZi4hBcKSRQK" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost/993927746-tigase-19 << <enabled resume="true" id="c04b488b-dea7-479e-8577-d09aec115ea0" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60"/>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost/993927746-tigase-19 >> <iq id="NQDBs7k6CfPYqZ12qezgAcJ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost/993927746-tigase-19 << <iq from="localhost" id="fxKHLT2hEKUPZi4hBcKSRQK" xmlns="jabber:client" type="result" to="user_4u6ny90027@localhost/993927746-tigase-19"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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-26 19:58:25 | user :: user_4u6ny90027@localhost/993927746-tigase-19 << <iq id="NQDBs7k6CfPYqZ12qezgAcJ" xmlns="jabber:client" type="result" to="user_4u6ny90027@localhost/993927746-tigase-19"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 19:58:25 | Disconnecting

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

2019-11-26 19:58:25 | [Mutex] notify: [disconnected]

2019-11-26 19:58:25 | [Mutex] received everything.

2019-11-26 19:58:25 | [Mutex] waiting for: [event]

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1pNzVkWnlXVzU4Y21iM3B0YUR4aQ==</auth>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pNzVkWnlXVzU4Y21iM3B0YUR4aVY3UVRkNjhqQXlMQUJRSGlOYXd5LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aTc1ZFp5V1c1OGNtYjNwdGFEeGlWN1FUZDY4akF5TEFCUUhpTmF3eSxwPWIybnlyRnYzYzFIYkJnNHBDaHg3N3RjSU51eWM4dUFuNzFrbnlkcTJmWEk9</response>

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

2019-11-26 19:58:25 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:25 | [Mutex] received everything.

2019-11-26 19:58:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:25 | [Mutex] waiting for: [event]

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1sWFFQdXpNV1h5T3JwMFBTZ3VkcQ==</auth>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sWFFQdXpNV1h5T3JwMFBTZ3VkcTYzMnhRenB1YkFONEI1Yms4bzVILHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bFhRUHV6TVdYeU9ycDBQU2d1ZHE2MzJ4UXpwdWJBTjRCNWJrOG81SCxwPUR4ditYOWdPQ0ZjYmYrSEtLeXQ5enN3cVBiSjJQY3N2OXllL1RkNElCbFk9</response>

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

2019-11-26 19:58:25 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:25 | [Mutex] received everything.

2019-11-26 19:58:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:25 | [Mutex] waiting for: [event]

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj0wVndOM0Z6TzZldzZBMVZyUXFWeg==</auth>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wVndOM0Z6TzZldzZBMVZyUXFWenlhUlpEd1p3VFFvZXRVUnozNjE5LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MFZ3TjNGek82ZXc2QTFWclFxVnp5YVJaRHdad1RRb2V0VVJ6MzYxOSxwPXlmZVdqYVl5K2ZkcW5xMlQvL2srNU9KQWQ3cUdZQlVkbndLZTJidmNQTmc9</response>

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

2019-11-26 19:58:25 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:25 | [Mutex] received everything.

2019-11-26 19:58:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:25 | [Mutex] waiting for: [event]

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1EcW5mR3lRWXpvdnZKZE9zdDNFdg==</auth>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EcW5mR3lRWXpvdnZKZE9zdDNFdjdYd3BDaFZtbzRIczdGZldHWnF4LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RHFuZkd5UVl6b3Z2SmRPc3QzRXY3WHdwQ2hWbW80SHM3RmZXR1pxeCxwPXN5UHVBN3lFNVIrMW5zV3lkMS9vblRQdUIwTzA3ZVBzdVc3MS9qT05vL0U9</response>

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

2019-11-26 19:58:25 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:25 | [Mutex] received everything.

2019-11-26 19:58:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:25 | [Mutex] waiting for: [event]

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:25 | user :: user_4u6ny90027@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-26 19:58:25 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj15RWliYXAxWVRUakVrMUVlckd1dw==</auth>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15RWliYXAxWVRUakVrMUVlckd1d1JiakF6ZnBJVVh6QzNlRTBtV1R0LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:25 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eUVpYmFwMVlUVGpFazFFZXJHdXdSYmpBemZwSVVYekMzZUUwbVdUdCxwPW9UVTVSWFBuQkNxcEpWTmxncG9icllNL0xGajNNRUpjR0FqVjl2SFRJcWM9</response>

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

2019-11-26 19:58:25 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:25 | [Mutex] received everything.

2019-11-26 19:58:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:25 | [Mutex] waiting for: [event]

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj16SnZTUloxOXpOTUFsbmthMXNIZg==</auth>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16SnZTUloxOXpOTUFsbmthMXNIZlR2ZkpkUXZSM1RZUDNramJxbnl2LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ekp2U1JaMTl6Tk1BbG5rYTFzSGZUdmZKZFF2UjNUWVAza2picW55dixwPXA3OGlkOWtJeVcrWDBWOXdDcDc1TmZVVGxUUFJ6eDRYY1BXMk1oZENld3M9</response>

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

2019-11-26 19:58:26 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:26 | [Mutex] received everything.

2019-11-26 19:58:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:26 | [Mutex] waiting for: [event]

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1jb3hyUnNJUW5haEJGZE9Sa0NYUw==</auth>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jb3hyUnNJUW5haEJGZE9Sa0NYU3VpTFBZaWIwZlBSaTJxNXRNZTE1LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y294clJzSVFuYWhCRmRPUmtDWFN1aUxQWWliMGZQUmkycTV0TWUxNSxwPXRWR3N5d0J4SDZYa3p5bjhrZVlFQkVYWTFHZFlYcTkzOHNPVDArWHc3QUU9</response>

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

2019-11-26 19:58:26 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:26 | [Mutex] received everything.

2019-11-26 19:58:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:26 | [Mutex] waiting for: [event]

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1KaTlCZElmbW5pbGdjbkpSWGxHRQ==</auth>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KaTlCZElmbW5pbGdjbkpSWGxHRWR1Y211RmtBWTI3N2FTWGtTR1JULHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Smk5QmRJZm1uaWxnY25KUlhsR0VkdWNtdUZrQVkyNzdhU1hrU0dSVCxwPUhZekRFZDkzUlpSTU5vQXpSam4wekRUTEpjQVJXMFVhM005ZmZnVStUS289</response>

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

2019-11-26 19:58:26 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:26 | [Mutex] received everything.

2019-11-26 19:58:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:26 | [Mutex] waiting for: [event]

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1peEhyNnNnd3d4VTNuY0xrVmRTcQ==</auth>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1peEhyNnNnd3d4VTNuY0xrVmRTcUdOV2w4cGNwaUdGaXl0aVhQanFiLHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aXhIcjZzZ3d3eFUzbmNMa1ZkU3FHTldsOHBjcGlHRml5dGlYUGpxYixwPW5uQXVubFVkUSt0b0ZFWE41MGoyYTlPSUMxd1RZZ1FQUzBtSm1vLzdzSWM9</response>

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

2019-11-26 19:58:26 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:26 | [Mutex] received everything.

2019-11-26 19:58:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:26 | [Mutex] notify: [event, disconnected]

2019-11-26 19:58:26 | [Mutex] waiting for: [event]

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj16dHV2V1JTN2F4andnY0ViaUplSw==</auth>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16dHV2V1JTN2F4andnY0ViaUplS1F0NW1sdk9jc1YyREdxMlRHcUUzLHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9enR1dldSUzdheGp3Z2NFYmlKZUtRdDVtbHZPY3NWMkRHcTJUR3FFMyxwPWFOYTJNRkQzYWhzMFA4cHowN0VxdGowamlEbHBNU0VjanRCSDh6VExQN009</response>

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

2019-11-26 19:58:26 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:26 | [Mutex] received everything.

2019-11-26 19:58:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:26 | [Mutex] waiting for: [event]

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj03YVNyWEFoZzk4cm9oRXdaQlRNMQ==</auth>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03YVNyWEFoZzk4cm9oRXdaQlRNMWhzMDh5U0EwdW0wUHduNzlLM2hILHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N2FTclhBaGc5OHJvaEV3WkJUTTFoczA4eVNBMHVtMFB3bjc5SzNoSCxwPUoxSDJxYXErMU5IVWErZGN2L3VRYTZRaG1MK2ZyRGJ2S0syc09mYVBVN0k9</response>

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

2019-11-26 19:58:26 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:26 | [Mutex] received everything.

2019-11-26 19:58:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:26 | [Mutex] waiting for: [event]

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1Dczg4YUJUMU5sOHNubUVMeHZWYQ==</auth>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Dczg4YUJUMU5sOHNubUVMeHZWYVZrdE1GVDI0Nzhpc3hyc2dPd1hwLHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:26 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q3M4OGFCVDFObDhzbm1FTHh2VmFWa3RNRlQyNDc4aXN4cnNnT3dYcCxwPXNBU2JxTnZzK0c5T0VZazJyZG4vcHhsdFFCd2JmeHdmazNvZUl5azU3R3M9</response>

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

2019-11-26 19:58:26 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:26 | [Mutex] received everything.

2019-11-26 19:58:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:26 | [Mutex] waiting for: [event]

2019-11-26 19:58:26 | user :: user_4u6ny90027@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-26 19:58:26 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1jM3lQMko3c3hXMTVETzhzUkVhbw==</auth>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jM3lQMko3c3hXMTVETzhzUkVhb0hMUW1FeFgxQmF6ZElXS21VQUFSLHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YzN5UDJKN3N4VzE1RE84c1JFYW9ITFFtRXhYMUJhemRJV0ttVUFBUixwPVVMbzA5M3J6b2kwb0NTai92WElQSVYwUFZWMWZyTmRseEt6QnpKMWI0N0k9</response>

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

2019-11-26 19:58:27 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:27 | [Mutex] received everything.

2019-11-26 19:58:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:27 | [Mutex] waiting for: [event]

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1zZ3F3d1FoZUF3bDJxOHUyd1drNg==</auth>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zZ3F3d1FoZUF3bDJxOHUyd1drNmlPWktxc0ZhMFdrOGxVQmR1WER1LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c2dxd3dRaGVBd2wycTh1MndXazZpT1pLcXNGYTBXazhsVUJkdVhEdSxwPUQ1SzhIdkpCSHp6TS8xZEFpc0VVSUxvL29oMHIwMEVVM2kzWHMxOGE5VFk9</response>

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

2019-11-26 19:58:27 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:27 | [Mutex] received everything.

2019-11-26 19:58:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:27 | [Mutex] waiting for: [event]

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1LSWh2SWl3a1VSTURIVXp5NlNnNw==</auth>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LSWh2SWl3a1VSTURIVXp5NlNnN2k4V2JtOThIaU1KRE9lVmp6MGM2LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S0lodklpd2tVUk1ESFV6eTZTZzdpOFdibTk4SGlNSkRPZVZqejBjNixwPWJEeFdBeUh6aHo5ajd4Um1YNThmM2x6YS9PU29wY0hEYjJySWVtaHZFZEk9</response>

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

2019-11-26 19:58:27 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:27 | [Mutex] received everything.

2019-11-26 19:58:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:27 | [Mutex] notify: [event, disconnected]

2019-11-26 19:58:27 | [Mutex] waiting for: [event]

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1GQUJ5Q3dsQWRKblliSFBGbmpKYg==</auth>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GQUJ5Q3dsQWRKblliSFBGbmpKYjNsZjlUWVJnVkVGTHFhRVFTTzA3LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RkFCeUN3bEFkSm5ZYkhQRm5qSmIzbGY5VFlSZ1ZFRkxxYUVRU08wNyxwPXNHMmZZYWNUejgyS01OYmV0c1Izdlh5d1BZdlF2cVlZQnd0ZUpMSDY4OFk9</response>

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

2019-11-26 19:58:27 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:27 | [Mutex] received everything.

2019-11-26 19:58:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:27 | [Mutex] waiting for: [event]

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1qZmhqcnYwZ1JtS2lXcWI0Mmw0eA==</auth>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qZmhqcnYwZ1JtS2lXcWI0Mmw0eE51NWhnV01oVGhLbHlsdkNHU1R1LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9amZoanJ2MGdSbUtpV3FiNDJsNHhOdTVoZ1dNaFRoS2x5bHZDR1NUdSxwPXBTQlBWYnpVWmowWC9ZU3JQTUU4bk1yeUgyQU01eHJneFlQaUVlL1FkWkU9</response>

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

2019-11-26 19:58:27 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:27 | [Mutex] received everything.

2019-11-26 19:58:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:27 | [Mutex] waiting for: [event]

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1FanhUanVSM3ptQkpNUnRUSUUyNQ==</auth>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FanhUanVSM3ptQkpNUnRUSUUyNXI3WmxjQWpvM2J4U0pmdDJ4aFJzLHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RWp4VGp1UjN6bUJKTVJ0VElFMjVyN1psY0FqbzNieFNKZnQyeGhScyxwPVRJYVYzZi9ZRHJNYnYyVnQySjR2N1pVVGg4YUZKMkViR1lBVVdEVklnYU09</response>

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

2019-11-26 19:58:27 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:27 | [Mutex] received everything.

2019-11-26 19:58:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:27 | [Mutex] waiting for: [event]

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1XQVkzVVFNNXljaE4ySW5zajBoZA==</auth>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XQVkzVVFNNXljaE4ySW5zajBoZEVqSDdRSWgxWHVFZ0F6Vk15QVVYLHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V0FZM1VRTTV5Y2hOMkluc2owaGRFakg3UUloMVh1RWdBelZNeUFVWCxwPXVjNWowMUZ0dUZnZzdZS0tKREtHRmR0WUw0UlM0Vm1jblI4YUxqUDdqQnM9</response>

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

2019-11-26 19:58:27 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:27 | [Mutex] received everything.

2019-11-26 19:58:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:27 | [Mutex] waiting for: [event]

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1nVGxidmx5cUEwUGFER0JwZkJxSg==</auth>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nVGxidmx5cUEwUGFER0JwZkJxSjBFOW5rWE4yUEFENjd1MDE2QklmLHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z1RsYnZseXFBMFBhREdCcGZCcUowRTlua1hOMlBBRDY3dTAxNkJJZixwPXRYMVdDQlRxRFVpaWpDdzh6Y1JLUWhCTXFOTThzZnl5RVZzUlFxQ0dOcU09</response>

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

2019-11-26 19:58:27 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:27 | [Mutex] received everything.

2019-11-26 19:58:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:27 | [Mutex] waiting for: [event]

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:27 | user :: user_4u6ny90027@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-26 19:58:27 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj12aUo3ZTBrMFlhMUxiMURwZTRNMQ==</auth>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12aUo3ZTBrMFlhMUxiMURwZTRNMU9rWklSd0g1aWdEczRzWXk1cERILHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:27 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dmlKN2UwazBZYTFMYjFEcGU0TTFPa1pJUndINWlnRHM0c1l5NXBESCxwPWhNeXdSblNkN2lEVDBkOTRsZ1F5SUIxT0F1SVBXcUMwd3hMSWRCWTI0VWs9</response>

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

2019-11-26 19:58:28 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:28 | [Mutex] received everything.

2019-11-26 19:58:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:28 | user :: user_4u6ny90027@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-26 19:58:28 | user :: user_4u6ny90027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:28 | user :: user_4u6ny90027@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-26 19:58:28 | user :: user_4u6ny90027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzR1Nm55OTAwMjcscj1rbHBHZGRaeWNvdjc0eGZDdUdNNw==</auth>

2019-11-26 19:58:28 | user :: user_4u6ny90027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rbHBHZGRaeWNvdjc0eGZDdUdNN29vZ1l1REV2MGRSTUw0TzZuWXd1LHM9ekZ4Rk9tcE1RS3p4b2c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:28 | user :: user_4u6ny90027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a2xwR2RkWnljb3Y3NHhmQ3VHTTdvb2dZdURFdjBkUk1MNE82bll3dSxwPXhDbEM5VzZlOHJzMnBmRTZ5MVZFaW1rUHY3VENPZFgvajNoYjdVM1RZbFE9</response>

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

2019-11-26 19:58:30 | [Mutex] waiting for: [user]

2019-11-26 19:58:30 | [Mutex] received everything.

2019-11-26 19:58:30 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-26 19:58:30 |

2019-11-26 19:58:30 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-26 19:58:30 | ------------------------------------

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@172e0e44

2019-11-26 19:58:30 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6ed310ae}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@19e9e2d1}, 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@1dd66534}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@58d4e8ea}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3f6f919a}, 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=Tue Nov 26 19:58:30 PST 2019}}}}

2019-11-26 19:58:30 | [Mutex] waiting for: [registration]

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@69c613cc

2019-11-26 19:58:30 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@19e9e2d1}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@1dd66534}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@58d4e8ea}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3f6f919a}, 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=Tue Nov 26 19:58:30 PST 2019}}}}

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@47973405

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

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

2019-11-26 19:58:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@38fb17a5}

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

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

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7bdba261

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@225a86a5

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

2019-11-26 19:58:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5c93b9f7}

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

2019-11-26 19:58:30 | user :: null >> <iq to="localhost" id="fBOP1p4lM0qR3qkNDgS8nSO" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-26 19:58:30 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6dbd4b5f}

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

2019-11-26 19:58:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3cb5cbff}

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1adbaea2

2019-11-26 19:58:30 | user :: null >> <iq to="localhost" id="QKduqgxp8KDjCAydyam3phX" type="set"><query xmlns="jabber:iq:register"><username>user_tb51360028</username><password>user_tb51360028</password><email>6e6a93b9-ae41-4446-b6e6-f99e0444a235@localhost</email></query></iq>

2019-11-26 19:58:30 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@824cdea8}

2019-11-26 19:58:30 | user :: null << <iq from="localhost" id="QKduqgxp8KDjCAydyam3phX" xmlns="jabber:client" type="result"/>

2019-11-26 19:58:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6cc27cf2}

2019-11-26 19:58:30 | [Mutex] received everything.

2019-11-26 19:58:30 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 19:58:30 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@38fb17a5, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5c93b9f7]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@19e9e2d1}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@1dd66534}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@58d4e8ea}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3f6f919a}, 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=Tue Nov 26 19:58:30 PST 2019}}}}

2019-11-26 19:58:30 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@38fb17a5, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5c93b9f7]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@19e9e2d1}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@1dd66534}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@58d4e8ea}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3f6f919a}, 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=Tue Nov 26 19:58:30 PST 2019}}}}

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2d5f3c9c

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@3f27e0fb

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@78cee703

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7143104

2019-11-26 19:58:30 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@537b56a6

2019-11-26 19:58:30 | user :: user_tb51360028@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-26 19:58:30 | user :: user_tb51360028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:30 | user :: user_tb51360028@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-26 19:58:30 | user :: user_tb51360028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RiNTEzNjAwMjgscj1sMTRhdzBkUkhMajlIblVmUDRlNQ==</auth>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sMTRhdzBkUkhMajlIblVmUDRlNVdHdjd4U08wYU80ZHBJVkFPbTZMLHM9YUtjODgzekJNMXlsU0E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bDE0YXcwZFJITGo5SG5VZlA0ZTVXR3Y3eFNPMGFPNGRwSVZBT202TCxwPU9VOHBtT2VZQjdjSnFPSU5qVUpmY0FpelFCY21nZzJIQlBlbWRRTUs5VUU9</response>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1mamR2blU0blBvbWFIS2pIcyt0MnJhUzBrN2ZQczFqWDR4c3dPS1JsOGk4PQ==</success>

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

2019-11-26 19:58:30 | user :: user_tb51360028@localhost >> <iq xmlns="jabber:client" id="UzEBwwbpOYkLEmKPXn9yaEE" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost << <iq id="UzEBwwbpOYkLEmKPXn9yaEE" xmlns="jabber:client" type="result" to="user_tb51360028@localhost/993927746-tigase-20"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_tb51360028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="ezChNXhOPKWiBxogFnKQ4fC" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost/993927746-tigase-20 << <iq id="ezChNXhOPKWiBxogFnKQ4fC" xmlns="jabber:client" type="result" to="user_tb51360028@localhost/993927746-tigase-20"/>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost/993927746-tigase-20 >> <iq to="localhost" id="kNgACEjXeW15aGKBkIsfN3v" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost/993927746-tigase-20 << <enabled resume="true" id="43de05ba-7c11-4171-b937-d5b0c085c5f7" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60"/>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost/993927746-tigase-20 >> <iq id="oCHHIUXXUaIxcsWdJVfKyqc" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 19:58:30 | user :: user_tb51360028@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-26 19:58:30 | user :: user_tb51360028@localhost/993927746-tigase-20 << <iq from="localhost" id="kNgACEjXeW15aGKBkIsfN3v" xmlns="jabber:client" type="result" to="user_tb51360028@localhost/993927746-tigase-20"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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-26 19:58:30 | user :: user_tb51360028@localhost/993927746-tigase-20 << <iq id="oCHHIUXXUaIxcsWdJVfKyqc" xmlns="jabber:client" type="result" to="user_tb51360028@localhost/993927746-tigase-20"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 19:58:30 | Disconnecting

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

2019-11-26 19:58:30 | [Mutex] notify: [disconnected]

2019-11-26 19:58:30 | [Mutex] received everything.

2019-11-26 19:58:30 | [Mutex] waiting for: [event]

2019-11-26 19:58:30 | user :: user_tb51360028@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-26 19:58:30 | user :: user_tb51360028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:30 | user :: user_tb51360028@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-26 19:58:30 | user :: user_tb51360028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RiNTEzNjAwMjgscj1ldG9pV0lFcmhqZFZGZEdrdHdidA==</auth>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ldG9pV0lFcmhqZFZGZEdrdHdidGRWR2tzZTd6QnpGZ3lZdkhUNm9pLHM9YUtjODgzekJNMXlsU0E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:30 | user :: user_tb51360028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZXRvaVdJRXJoamRWRmRHa3R3YnRkVkdrc2U3ekJ6Rmd5WXZIVDZvaSxwPUpyYnBJUWNyZnErREVRNmNrWDl6UTdUdTV5RVdrZGdzRjY5WFM1Um9iTVk9</response>

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

2019-11-26 19:58:30 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:30 | [Mutex] received everything.

2019-11-26 19:58:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:30 | [Mutex] waiting for: [event]

2019-11-26 19:58:30 | user :: user_tb51360028@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-26 19:58:30 | user :: user_tb51360028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:31 | user :: user_tb51360028@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-26 19:58:31 | user :: user_tb51360028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RiNTEzNjAwMjgscj05c3ZvcDdZY3QybWJPZFF5bXRsVg==</auth>

2019-11-26 19:58:31 | user :: user_tb51360028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05c3ZvcDdZY3QybWJPZFF5bXRsVnlLcjhVek5QZ0NQRkl1RDFZUEg0LHM9YUtjODgzekJNMXlsU0E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:31 | user :: user_tb51360028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OXN2b3A3WWN0Mm1iT2RReW10bFZ5S3I4VXpOUGdDUEZJdUQxWVBINCxwPVc5MzUvWVptdlNkVFNkN2wwS3N5TmRQTWlaNVI1Q0F2S1RoRWs5QThWYWc9</response>

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

2019-11-26 19:58:31 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:31 | [Mutex] received everything.

2019-11-26 19:58:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:31 | [Mutex] waiting for: [event]

2019-11-26 19:58:31 | user :: user_tb51360028@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-26 19:58:31 | user :: user_tb51360028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:31 | user :: user_tb51360028@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-26 19:58:31 | user :: user_tb51360028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RiNTEzNjAwMjgscj1HZVR5TTBHaEVhWkJMOFBNWWNoeQ==</auth>

2019-11-26 19:58:31 | user :: user_tb51360028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HZVR5TTBHaEVhWkJMOFBNWWNoeTNhaVZMRjBCaGJmM01uRDJDMmgzLHM9YUtjODgzekJNMXlsU0E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:31 | user :: user_tb51360028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R2VUeU0wR2hFYVpCTDhQTVljaHkzYWlWTEYwQmhiZjNNbkQyQzJoMyxwPThZTVdwU0lTZUxZUzBQY0lVSWI5MHJSb1NHVHhzb3R6OWN4cTBvcHdkejA9</response>

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

2019-11-26 19:58:31 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:31 | [Mutex] received everything.

2019-11-26 19:58:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:31 | [Mutex] waiting for: [event]

2019-11-26 19:58:31 | user :: user_tb51360028@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-26 19:58:31 | user :: user_tb51360028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:31 | user :: user_tb51360028@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-26 19:58:31 | user :: user_tb51360028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RiNTEzNjAwMjgscj1HbXZJNHFNRm1rNWdISmZ0MG5kWQ==</auth>

2019-11-26 19:58:31 | user :: user_tb51360028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HbXZJNHFNRm1rNWdISmZ0MG5kWWVEZ0NoMVN5aVZxaVBmMjM3U2FoLHM9YUtjODgzekJNMXlsU0E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:31 | user :: user_tb51360028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R212STRxTUZtazVnSEpmdDBuZFllRGdDaDFTeWlWcWlQZjIzN1NhaCxwPTVwY3JjZDhLSldWa2VWZ2g1VUIycDZLeDRJdFZFSUlUWFVuQzhoMEJpS3M9</response>

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

2019-11-26 19:58:31 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:31 | [Mutex] received everything.

2019-11-26 19:58:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:31 | user :: user_tb51360028@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-26 19:58:31 | user :: user_tb51360028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:31 | user :: user_tb51360028@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-26 19:58:31 | user :: user_tb51360028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RiNTEzNjAwMjgscj1RbUdMcEZoZnIzRFJ2WEdtVFZCaQ==</auth>

2019-11-26 19:58:31 | user :: user_tb51360028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RbUdMcEZoZnIzRFJ2WEdtVFZCaWJZcXFEWm41VjlNSElDSjFSR3hpLHM9YUtjODgzekJNMXlsU0E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:31 | user :: user_tb51360028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UW1HTHBGaGZyM0RSdlhHbVRWQmliWXFxRFpuNVY5TUhJQ0oxUkd4aSxwPW5lWEdTTXVOZGVFalJuNUxVQ0Y3NGhzWlhLUTMxMWhKRFJuTld5ajRuWW89</response>

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

2019-11-26 19:58:33 | [Mutex] waiting for: [user]

2019-11-26 19:58:33 | [Mutex] received everything.

2019-11-26 19:58:33 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-26 19:58:33 |

2019-11-26 19:58:33 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-26 19:58:33 | ------------------------------------

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6fe6b13d

2019-11-26 19:58:33 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6ed310ae}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@612152b1}, 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@651eda4d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@201c588a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7aa96aed}, 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=Tue Nov 26 19:58:33 PST 2019}}}}

2019-11-26 19:58:33 | [Mutex] waiting for: [registration]

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@11761bd3

2019-11-26 19:58:33 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@612152b1}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@651eda4d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@201c588a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7aa96aed}, 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=Tue Nov 26 19:58:33 PST 2019}}}}

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2297702

2019-11-26 19:58:33 | 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-26 19:58:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4033a7c5}

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

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

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@717c432c

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@50f56653

2019-11-26 19:58:33 | 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-26 19:58:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@192d9a28}

2019-11-26 19:58:33 | 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-26 19:58:33 | user :: null >> <iq to="localhost" id="w2RNIu0lZrhOGGIJsZdNXax" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-26 19:58:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8db59169}

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

2019-11-26 19:58:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@447d1b47}

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@578b55c7

2019-11-26 19:58:33 | user :: null >> <iq to="localhost" id="v1MUVY02p7HNQKOYfu3l3tc" type="set"><query xmlns="jabber:iq:register"><username>user_d1e3y10029</username><password>user_d1e3y10029</password><email>1cb03d50-b143-4388-8d51-b0cfa17d9cab@localhost</email></query></iq>

2019-11-26 19:58:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4fc6c05f}

2019-11-26 19:58:33 | user :: null << <iq from="localhost" id="v1MUVY02p7HNQKOYfu3l3tc" xmlns="jabber:client" type="result"/>

2019-11-26 19:58:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2cb7769b}

2019-11-26 19:58:33 | [Mutex] received everything.

2019-11-26 19:58:33 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 19:58:33 | 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;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4033a7c5, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@192d9a28]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@612152b1}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@651eda4d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@201c588a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7aa96aed}, 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=Tue Nov 26 19:58:33 PST 2019}}}}

2019-11-26 19:58:33 | 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;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4033a7c5, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@192d9a28]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@612152b1}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@651eda4d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@201c588a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7aa96aed}, 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=Tue Nov 26 19:58:33 PST 2019}}}}

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@593e55ff

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7535dabc

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@789d8cb0

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6f092e96

2019-11-26 19:58:33 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@44330f25

2019-11-26 19:58:33 | user :: user_d1e3y10029@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-26 19:58:33 | user :: user_d1e3y10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:33 | user :: user_d1e3y10029@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-26 19:58:33 | user :: user_d1e3y10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2QxZTN5MTAwMjkscj1vdHlQZmttdGpuOVMxV292aHJsMw==</auth>

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vdHlQZmttdGpuOVMxV292aHJsM0pCVjBGQXVRMVJTdGxSMDlNT0ZvLHM9K2t3WXloYmJqWk9PZkE9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b3R5UGZrbXRqbjlTMVdvdmhybDNKQlYwRkF1UTFSU3RsUjA5TU9GbyxwPWw1WThyUlpsVzd5UTl1VWpSbUcyUjdSdFJJZUg0a1hGUEpiNnVyYnIvRTQ9</response>

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1HWmdWa1dUOGtJdTE3NUJRM1JmR21vckVEekZiOFFtbSt5Z0NuTm5uUEZNPQ==</success>

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

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost >> <iq xmlns="jabber:client" id="lM1skFFEMHrS6AhGqS5tpdG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost << <iq id="lM1skFFEMHrS6AhGqS5tpdG" xmlns="jabber:client" type="result" to="user_d1e3y10029@localhost/993927746-tigase-21"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_d1e3y10029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="W1ISTPEEGt4cqbFNZewm4rS" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost/993927746-tigase-21 << <iq id="W1ISTPEEGt4cqbFNZewm4rS" xmlns="jabber:client" type="result" to="user_d1e3y10029@localhost/993927746-tigase-21"/>

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost/993927746-tigase-21 >> <iq to="localhost" id="YRcpOYkLEmKPXn9yaEEBctb" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost/993927746-tigase-21 << <enabled resume="true" id="51d986db-7cb0-41f3-94c0-0aa4e4e95352" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60"/>

2019-11-26 19:58:33 | user :: user_d1e3y10029@localhost/993927746-tigase-21 >> <iq id="sSdrS6AhGqS5tpdGqaGFkJH" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 19:58:33 | user :: user_d1e3y10029@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-26 19:58:33 | user :: user_d1e3y10029@localhost/993927746-tigase-21 << <iq from="localhost" id="YRcpOYkLEmKPXn9yaEEBctb" xmlns="jabber:client" type="result" to="user_d1e3y10029@localhost/993927746-tigase-21"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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-26 19:58:33 | user :: user_d1e3y10029@localhost/993927746-tigase-21 << <iq id="sSdrS6AhGqS5tpdGqaGFkJH" xmlns="jabber:client" type="result" to="user_d1e3y10029@localhost/993927746-tigase-21"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 19:58:33 | Disconnecting

2019-11-26 19:58:33 | [Mutex] notify: [disconnected]

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

2019-11-26 19:58:33 | [Mutex] received everything.

2019-11-26 19:58:33 | [Mutex] waiting for: [event]

2019-11-26 19:58:33 | user :: user_d1e3y10029@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-26 19:58:33 | user :: user_d1e3y10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:34 | user :: user_d1e3y10029@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-26 19:58:34 | user :: user_d1e3y10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2QxZTN5MTAwMjkscj1KZnJ6QmxqVDEwVlVJMkpyT0ZERw==</auth>

2019-11-26 19:58:34 | user :: user_d1e3y10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KZnJ6QmxqVDEwVlVJMkpyT0ZER2o0bGxiRFhpd1RPcmhOczJRZ0xmLHM9K2t3WXloYmJqWk9PZkE9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:34 | user :: user_d1e3y10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SmZyekJsalQxMFZVSTJKck9GREdqNGxsYkRYaXdUT3JoTnMyUWdMZixwPXB1WUF5YkVoRlZrdmRVSkhUUnJzdEFIdTRLTmswQW9Tbk1mV0tJbERnL3c9</response>

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

2019-11-26 19:58:34 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:34 | [Mutex] received everything.

2019-11-26 19:58:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:34 | [Mutex] waiting for: [event]

2019-11-26 19:58:34 | user :: user_d1e3y10029@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-26 19:58:34 | user :: user_d1e3y10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:34 | user :: user_d1e3y10029@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-26 19:58:34 | user :: user_d1e3y10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2QxZTN5MTAwMjkscj1KQXd5Wmd3YXFkek1EZ1ZRTjR3Yw==</auth>

2019-11-26 19:58:34 | user :: user_d1e3y10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KQXd5Wmd3YXFkek1EZ1ZRTjR3Y1F1UUxsYUMyVGxQTm5xVmlxbG9HLHM9S3JqU0xXYUEzcGEzV3c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:34 | user :: user_d1e3y10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SkF3eVpnd2FxZHpNRGdWUU40d2NRdVFMbGFDMlRsUE5ucVZpcWxvRyxwPUh1bWtsNW8wZ3JxSFlRYWdTaGhORm5PdVZXbz0=</response>

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

2019-11-26 19:58:34 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:34 | [Mutex] received everything.

2019-11-26 19:58:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:34 | [Mutex] waiting for: [event]

2019-11-26 19:58:34 | user :: user_d1e3y10029@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-26 19:58:34 | user :: user_d1e3y10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:34 | user :: user_d1e3y10029@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-26 19:58:34 | user :: user_d1e3y10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2QxZTN5MTAwMjkscj1CdUFZQ0NkeDNoV0xrWWtuN3p3Tw==</auth>

2019-11-26 19:58:34 | user :: user_d1e3y10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CdUFZQ0NkeDNoV0xrWWtuN3p3T3pwRElwTHRCNko4OVYwQkZBSmZXLHM9S3JqU0xXYUEzcGEzV3c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:34 | user :: user_d1e3y10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QnVBWUNDZHgzaFdMa1lrbjd6d096cERJcEx0QjZKODlWMEJGQUpmVyxwPU80Vi8yYkV4ZzdlUitBM01IYkZpV1E4Z00xRT0=</response>

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

2019-11-26 19:58:34 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:34 | [Mutex] notify: [event, disconnected]

2019-11-26 19:58:34 | [Mutex] received everything.

2019-11-26 19:58:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:34 | [Mutex] waiting for: [event]

2019-11-26 19:58:34 | user :: user_d1e3y10029@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-26 19:58:34 | user :: user_d1e3y10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:34 | user :: user_d1e3y10029@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-26 19:58:34 | user :: user_d1e3y10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2QxZTN5MTAwMjkscj1kbEI3YVRtcHZkYVBycE9mUE9tWg==</auth>

2019-11-26 19:58:34 | user :: user_d1e3y10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kbEI3YVRtcHZkYVBycE9mUE9tWnJWeHBqeHJ4UzRNVnRwTFltM3ZDLHM9S3JqU0xXYUEzcGEzV3c9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:34 | user :: user_d1e3y10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZGxCN2FUbXB2ZGFQcnBPZlBPbVpyVnhwanhyeFM0TVZ0cExZbTN2QyxwPXZneFNuZVd2VmNrOU5KMERKUXZQYTdMV213ND0=</response>

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

2019-11-26 19:58:34 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:34 | [Mutex] received everything.

2019-11-26 19:58:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:34 | user :: user_d1e3y10029@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-26 19:58:34 | user :: user_d1e3y10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 19:58:34 | user :: user_d1e3y10029@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-26 19:58:34 | user :: user_d1e3y10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2QxZTN5MTAwMjkscj1QUDd3bDRhQnp3TzdyTmZvT0FtYw==</auth>

2019-11-26 19:58:34 | user :: user_d1e3y10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QUDd3bDRhQnp3TzdyTmZvT0FtY3RDRk5YYmpCeDdTR3JodWFwTjl3LHM9K2t3WXloYmJqWk9PZkE9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:34 | user :: user_d1e3y10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UFA3d2w0YUJ6d083ck5mb09BbWN0Q0ZOWGJqQng3U0dyaHVhcE45dyxwPXo5ald3WjQvb3VGYVVPdTZPeldyVS9GQmJaZFRxZnk4KzZCS1pvSktmL0U9</response>

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

2019-11-26 19:58:36 | [Mutex] waiting for: [user]

2019-11-26 19:58:36 | [Mutex] received everything.

2019-11-26 19:58:36 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-26 19:58:36 |

2019-11-26 19:58:36 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-26 19:58:36 | ------------------------------------

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2e0a7aa6

2019-11-26 19:58:36 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6ed310ae}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20cd8117}, 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@24f211d6}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61f08b2c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c5202fe}, 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=Tue Nov 26 19:58:36 PST 2019}}}}

2019-11-26 19:58:36 | [Mutex] waiting for: [registration]

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@505bed5a

2019-11-26 19:58:36 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20cd8117}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@24f211d6}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61f08b2c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c5202fe}, 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=Tue Nov 26 19:58:36 PST 2019}}}}

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@64133a26

2019-11-26 19:58:36 | 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-26 19:58:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1df7463}

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

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

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@d96c354

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@228ce81

2019-11-26 19:58:36 | 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-26 19:58:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f1716e8}

2019-11-26 19:58:36 | 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-26 19:58:36 | user :: null >> <iq to="localhost" id="M1yrfKHuqgxp8KDjCAydyam" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-26 19:58:36 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@fb186b22}

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

2019-11-26 19:58:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5910905}

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3ea6f680

2019-11-26 19:58:36 | user :: null >> <iq to="localhost" id="KNQJHLT2hEKUPZi4hBcKSRQ" type="set"><query xmlns="jabber:iq:register"><username>user_vsaece0030</username><password>user_vsaece0030</password><email>e84c20e8-1307-4119-8f30-a0751f89e730@localhost</email></query></iq>

2019-11-26 19:58:36 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1ffceb96}

2019-11-26 19:58:36 | user :: null << <iq from="localhost" id="KNQJHLT2hEKUPZi4hBcKSRQ" xmlns="jabber:client" type="result"/>

2019-11-26 19:58:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7a3e6b13}

2019-11-26 19:58:36 | [Mutex] received everything.

2019-11-26 19:58:36 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 19:58:36 | 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;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1df7463, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f1716e8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20cd8117}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@24f211d6}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61f08b2c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c5202fe}, 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=Tue Nov 26 19:58:36 PST 2019}}}}

2019-11-26 19:58:36 | 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;@6ed310ae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1df7463, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f1716e8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20cd8117}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2fee1a95}, 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@24f211d6}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61f08b2c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c5202fe}, 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=Tue Nov 26 19:58:36 PST 2019}}}}

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3d5982ea

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@308d7d65

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@39969f02

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@30f90dd0

2019-11-26 19:58:36 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@414697f7

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

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

2019-11-26 19:58:36 | user :: user_vsaece0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vWFVHdUlTRG12TWxlMUhBaGNQaHU1UWxnR0s0ZVFNbzM4bjBoN2dnLHM9NWhteGU4NGorTmNFK1E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:36 | user :: user_vsaece0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b1hVR3VJU0Rtdk1sZTFIQWhjUGh1NVFsZ0dLNGVRTW8zOG4waDdnZyxwPW82U3ZtU1dtaFU4YVZHOUFaMGF0eDl1SSsyTG9IeWdNdzg5RDgvQ3dDdHM9</response>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj14U3VDZFlmT3JRd1dPdzdXanBTS05nSWZBUml1ZkRFUDc0QmNTM0VxZ0ZJPQ==</success>

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

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost >> <iq xmlns="jabber:client" id="Ed4mMS6v05pbJIDmaKvl0u7" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-22 << <iq id="yXgy8BvtlWWcKNAfJP1iNGO" xmlns="jabber:client" type="result" to="user_vsaece0030@localhost/993927746-tigase-22"/>

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

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

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-22 << <enabled resume="true" id="0269eb0b-44f6-4799-8690-28f74d242b6e" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60"/>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-22 >> <iq id="ZU34umPMCgR1vp4cIMRIvfR" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 19:58:37 | user :: user_vsaece0030@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-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-22 << <iq from="localhost" id="sZkFk0oTUSMT5DFAeMU7exj" xmlns="jabber:client" type="result" to="user_vsaece0030@localhost/993927746-tigase-22"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-22 << <iq id="ZU34umPMCgR1vp4cIMRIvfR" xmlns="jabber:client" type="result" to="user_vsaece0030@localhost/993927746-tigase-22"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 19:58:37 | Disconnecting

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

2019-11-26 19:58:37 | [Mutex] notify: [disconnected]

2019-11-26 19:58:37 | [Mutex] received everything.

2019-11-26 19:58:37 | [Mutex] waiting for: [event]

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

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

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04NllLRVA3M3NWWUtTQ3pNV3lvMzZwQnM3Z2dIeEYwb3F2dVNtNnR4LHM9NWhteGU4NGorTmNFK1E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ODZZS0VQNzNzVllLU0N6TVd5bzM2cEJzN2dnSHhGMG9xdnVTbTZ0eCxwPUd2amd2Z0xvODB1K25GTkJiaTdsSlFkOVljYVJLMnN0QXlJdXR2Q0JwV3c9</response>

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

2019-11-26 19:58:37 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:37 | [Mutex] received everything.

2019-11-26 19:58:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:37 | [Mutex] waiting for: [event]

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

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

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XcUFnamVnN2Z1YmdxaFZVdzc1dnFwUkZKUmhUNFFtalBWcVQ5MHd6LHM9NWhteGU4NGorTmNFK1E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V3FBZ2plZzdmdWJncWhWVXc3NXZxcFJGSlJoVDRRbWpQVnFUOTB3eixwPUc1czQ0WHNxQmp2ZDJEMGJiVFZ5NVd1anZKM0FraUs0TmxHUDNnYWROS1E9</response>

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

2019-11-26 19:58:37 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:37 | [Mutex] notify: [event, disconnected]

2019-11-26 19:58:37 | [Mutex] received everything.

2019-11-26 19:58:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 19:58:37 | [Mutex] waiting for: [event]

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

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

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wSVpVbzBYWm5TaUs5bFJVUlFkTDhmOHM4N09FNEdvYTY4a0UxeU85LHM9NWhteGU4NGorTmNFK1E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MElaVW8wWFpuU2lLOWxSVVJRZEw4ZjhzODdPRTRHb2E2OGtFMXlPOSxwPUJHelhUcHpzNE4yNENhMy83cW5lRHhMVDZUakZUVDVWdTh3T2RiT2lScms9</response>

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

2019-11-26 19:58:37 | [Mutex] notify: [event, authFailed]

2019-11-26 19:58:37 | [Mutex] received everything.

2019-11-26 19:58:37 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kN3Z4MUZ3OXhkNEw4c1U0NG1qbndPWlBQaFl6NUh6RmVJc1dzNzltLHM9NWhteGU4NGorTmNFK1E9PSxpPTQwOTY=</challenge>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZDd2eDFGdzl4ZDRMOHNVNDRtam53T1pQUGhZejVIekZlSXNXczc5bSxwPWJ1T2pDUHEzUy84andYSkc4TEUzcHpDa01TbFlMN0RFRFBzQzZRNUNTZE09</response>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj11eXlKNmpadUtJM3l2MWhUTlBVdHNINFNTNFJOYitOT3F3ckhCM1BwOXBjPQ==</success>

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

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost >> <iq xmlns="jabber:client" id="4U1lZrhOGGIJsZdNXaxaMYX" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost << <iq id="4U1lZrhOGGIJsZdNXaxaMYX" xmlns="jabber:client" type="result" to="user_vsaece0030@localhost/993927746-tigase-23"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_vsaece0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="dcRGr7BzoZ4AAbHIUXXUaIx" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-23 << <iq id="dcRGr7BzoZ4AAbHIUXXUaIx" xmlns="jabber:client" type="result" to="user_vsaece0030@localhost/993927746-tigase-23"/>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="R0fUethSeBfuk2bu26xndPU" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-23 << <enabled resume="true" id="bc4b8466-7ac1-4193-82a5-3470dfb4e573" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60"/>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-23 >> <iq id="oW1l0u7hysiHw6eNTfT28Aw" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-23 << <iq from="localhost" id="R0fUethSeBfuk2bu26xndPU" xmlns="jabber:client" type="result" to="user_vsaece0030@localhost/993927746-tigase-23"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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-26 19:58:37 | user :: user_vsaece0030@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-26 19:58:37 | user :: user_vsaece0030@localhost/993927746-tigase-23 << <iq id="oW1l0u7hysiHw6eNTfT28Aw" xmlns="jabber:client" type="result" to="user_vsaece0030@localhost/993927746-tigase-23"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 19:58:37 | Disconnecting

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

2019-11-26 19:58:37 | [Mutex] notify: [disconnected]

2019-11-26 19:58:37 | [Mutex] received everything.

2019-11-26 19:58:39 | [Mutex] waiting for: [user]

2019-11-26 19:58:39 | [Mutex] received everything.

2019-11-26 19:58:39 | [Mutex] isItemNotified: user:ok:true :: true