Brute Force Prevention

Test duration: 16.238s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 6.193s
2019-10-13 20:24:33 |

2019-10-13 20:24:33 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:24:33 | ------------------------------------

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@65e27ca8

2019-10-13 20:24:33 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6b258e64}, 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@6f1a17d8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2a18845f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c69aa88}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:33 PDT 2019}}}}

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1bf849cf

2019-10-13 20:24:33 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6b258e64}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@6f1a17d8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2a18845f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c69aa88}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:33 PDT 2019}}}}

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@246339bf

2019-10-13 20:24:33 | [Mutex] waiting for: [registration]

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

2019-10-13 20:24:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4a377b10}

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

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

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

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5b9ba534

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2f439b9

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

2019-10-13 20:24:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3f675699}

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

2019-10-13 20:24:33 | user :: null >> <iq to="localhost" id="tK25gGKURQSaN1gX6FogHSU" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:24:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@906d172b}

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

2019-10-13 20:24:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4e79459e}

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@48cdeb60

2019-10-13 20:24:33 | user :: null >> <iq to="localhost" id="5PfTfV4zk7i4j6mdBfyAeMJ" type="set"><query xmlns="jabber:iq:register"><username>user_5wtjiz0019</username><password>user_5wtjiz0019</password><email>d95c2804-b3bb-46c3-85fe-582de916070f@localhost</email></query></iq>

2019-10-13 20:24:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@eea7b66}

2019-10-13 20:24:33 | user :: null << <iq type="result" from="localhost" xmlns="jabber:client" id="5PfTfV4zk7i4j6mdBfyAeMJ"/>

2019-10-13 20:24:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6b573a31}

2019-10-13 20:24:33 | [Mutex] received everything.

2019-10-13 20:24:33 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:24:33 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4a377b10, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3f675699]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6b258e64}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@6f1a17d8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2a18845f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c69aa88}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:33 PDT 2019}}}}

2019-10-13 20:24:33 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4a377b10, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3f675699]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6b258e64}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@6f1a17d8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2a18845f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c69aa88}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:33 PDT 2019}}}}

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6e817a5c

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6ad097a7

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4de1e776

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1fb5ca49

2019-10-13 20:24:33 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@7a830079

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

2019-10-13 20:24:33 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1UZWtpUGt2RVhLN0Q3bkpISUV0MQ==</auth>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UZWtpUGt2RVhLN0Q3bkpISUV0MUtXcExrR3RPZ0dabkZJTGRxM2w3LHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VGVraVBrdkVYSzdEN25KSElFdDFLV3BMa0d0T2dHWm5GSUxkcTNsNyxwPVd6MFhMcUFJSTRQVEFXK3J0ZmJGRGJLWUJzU0lNSUdOU3VzRk9LdkdRSDQ9</response>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VdzJFaGZ6UDk2OEhxNFNJbHdXYWV0RjV3ZzBLUnQrbkhmang1SUhMWkpvPQ==</success>

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <iq xmlns="jabber:client" id="9Sm8snO6neCJDjGQKONZiMG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost << <iq type="result" xmlns="jabber:client" id="9Sm8snO6neCJDjGQKONZiMG" to="user_5wtjiz0019@localhost/993927746-tigase-13"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_5wtjiz0019@localhost/993927746-tigase-13</jid></bind></iq>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost/993927746-tigase-13 >> <iq xmlns="jabber:client" id="rZFv8iGwqgzgIQ9JGNM16Gx" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost/993927746-tigase-13 << <iq type="result" xmlns="jabber:client" id="rZFv8iGwqgzgIQ9JGNM16Gx" to="user_5wtjiz0019@localhost/993927746-tigase-13"/>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost/993927746-tigase-13 >> <iq to="localhost" id="kJRL04s5zs6kGs4wsX2gWl7" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost/993927746-tigase-13 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost/993927746-tigase-13 << <enabled location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="2a8dee98-5880-4c4a-a796-a42ed296fbd7" resume="true" max="60"/>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost/993927746-tigase-13 >> <iq id="3KSRUeVhMZaNEMJW2zjFogA" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost/993927746-tigase-13 << <iq type="result" xmlns="jabber:client" id="3KSRUeVhMZaNEMJW2zjFogA" to="user_5wtjiz0019@localhost/993927746-tigase-13"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:24:34 | Disconnecting

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

2019-10-13 20:24:34 | [Mutex] notify: [disconnected]

2019-10-13 20:24:34 | [Mutex] received everything.

2019-10-13 20:24:34 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj10emZOaW1pb0dLTmt1Nzh6NnF0UA==</auth>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10emZOaW1pb0dLTmt1Nzh6NnF0UFIxWE1QMXVKanRURVVkbURXa3RlLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dHpmTmltaW9HS05rdTc4ejZxdFBSMVhNUDF1Smp0VEVVZG1EV2t0ZSxwPUZ3ZWtSa21wcDhjYjVmYTZJcHViVk9KVzRPNTNlU28zcURFNEFDR2FLSkE9</response>

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

2019-10-13 20:24:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:34 | [Mutex] received everything.

2019-10-13 20:24:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:34 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1qejNHY1hqNW0xS1VKU3dEZnNldw==</auth>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qejNHY1hqNW0xS1VKU3dEZnNld2pRZE9DZFB0R2t1REtXQllhNHFVLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9anozR2NYajVtMUtVSlN3RGZzZXdqUWRPQ2RQdEdrdURLV0JZYTRxVSxwPVBFLytLandjQTFOU2ltV2x4NzhGVlpBRllmdmlCbEwydGlXSmZSRjNJMUk9</response>

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

2019-10-13 20:24:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:34 | [Mutex] received everything.

2019-10-13 20:24:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:34 | [Mutex] notify: [event, disconnected]

2019-10-13 20:24:34 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1IZzBoNUY5RmpzZWcxSG9sTVliTw==</auth>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IZzBoNUY5RmpzZWcxSG9sTVliT3pBOWlZbkc5elNmeW5nOHpib0h5LHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SGcwaDVGOUZqc2VnMUhvbE1ZYk96QTlpWW5HOXpTZnluZzh6Ym9IeSxwPUs2Y1kwczJJTzZTNXVubFpqQTdkdzN3ODliVWdDM2hkMHhjZjRzT0lLMms9</response>

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

2019-10-13 20:24:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:34 | [Mutex] received everything.

2019-10-13 20:24:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:34 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj0wUHc1Yzd2SGcwRzlKcVVsNXByMg==</auth>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wUHc1Yzd2SGcwRzlKcVVsNXByMjFrTXZCZldBMHZRcDcyaW5Ock1lLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MFB3NWM3dkhnMEc5SnFVbDVwcjIxa012QmZXQTB2UXA3MmluTnJNZSxwPTFKMDVLQkxsL01CdzZJSzVlZ3FVL01vRmQ0VjdlU3VBSUQ2c3Rya0ZrMlE9</response>

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

2019-10-13 20:24:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:34 | [Mutex] received everything.

2019-10-13 20:24:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:34 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1sQnE2WW42cElDeHllalB3aVNhSg==</auth>

2019-10-13 20:24:34 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sQnE2WW42cElDeHllalB3aVNhSlB5ZDZEdTM1azdscXJGOWJ1WGxnLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bEJxNlluNnBJQ3h5ZWpQd2lTYUpQeWQ2RHUzNWs3bHFyRjlidVhsZyxwPW5FZUgyVDQ3MS9CZDBNdldSSnp3TTNEWURaRzlhUFd3cG5XdXRTTWphRlk9</response>

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

2019-10-13 20:24:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:35 | [Mutex] notify: [event, disconnected]

2019-10-13 20:24:35 | [Mutex] received everything.

2019-10-13 20:24:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:35 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1UcXFTZ1V0dW8wWURoNTJZSVA5aA==</auth>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UcXFTZ1V0dW8wWURoNTJZSVA5aHhHY1VoQzRKVW1ad3h2N3ZxYVpJLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VHFxU2dVdHVvMFlEaDUyWUlQOWh4R2NVaEM0SlVtWnd4djd2cWFaSSxwPXBoREFYNmhvei9FR0NZd0hUc3RIOTVsSjNEa0E1WTNKWHAvS0lLZUZQUW89</response>

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

2019-10-13 20:24:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:35 | [Mutex] received everything.

2019-10-13 20:24:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:35 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1zTWY4VmNvSGV2N0YxNVdaaGJPbw==</auth>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zTWY4VmNvSGV2N0YxNVdaaGJPb1ZBYnlUWENxQVdrc05GYXJtbzFQLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c01mOFZjb0hldjdGMTVXWmhiT29WQWJ5VFhDcUFXa3NORmFybW8xUCxwPVFPSHc0RmhwbjBtR0orNkJpZXhBTEVEdW53b0JmSFFDWU1ZSGtQQ2VDb009</response>

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

2019-10-13 20:24:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:35 | [Mutex] received everything.

2019-10-13 20:24:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:35 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj00cU9Cd0k3WVRCTWo4Y2ZaTjdkUA==</auth>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00cU9Cd0k3WVRCTWo4Y2ZaTjdkUHlZQncyOGNqUnpHMnpBN0R1cm5DLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NHFPQndJN1lUQk1qOGNmWk43ZFB5WUJ3MjhjalJ6RzJ6QTdEdXJuQyxwPS9URDRJTG1CNDRxNExIdmtXa3VpSW5YV1ovMTdzZUMwTDZGRnk5MHdlK1U9</response>

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

2019-10-13 20:24:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:35 | [Mutex] received everything.

2019-10-13 20:24:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:35 | [Mutex] notify: [event, disconnected]

2019-10-13 20:24:35 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1QT2l3cTRROGE5djVQM1F4U1MxcA==</auth>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QT2l3cTRROGE5djVQM1F4U1MxcG5MbXJkOVJOcldhQWszOGNVUzJqLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UE9pd3E0UThhOXY1UDNReFNTMXBuTG1yZDlSTnJXYUFrMzhjVVMyaixwPStDNyt0VGpDSGNJM0wzK2t0QXNkQ3VtaVJGQjFyNlJ1NFNVZ2VHY0dJWXM9</response>

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

2019-10-13 20:24:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:35 | [Mutex] received everything.

2019-10-13 20:24:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:35 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1ianh3cXdNQXRNRkoxR2NhdHVnaA==</auth>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ianh3cXdNQXRNRkoxR2NhdHVnaGxNYjdWYlpXNTlRVUZwclY0RHVwLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Ymp4d3F3TUF0TUZKMUdjYXR1Z2hsTWI3VmJaVzU5UVVGcHJWNER1cCxwPUNrcHgzYlROUWM4czIrSmJPQnVwQ1NqbnEwcEIzTzRZdnRlaHVPeWlkNUE9</response>

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

2019-10-13 20:24:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:35 | [Mutex] notify: [event, disconnected]

2019-10-13 20:24:35 | [Mutex] received everything.

2019-10-13 20:24:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:35 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1UODdlN1NVaG92Qmp2SmxFaVcwdg==</auth>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UODdlN1NVaG92Qmp2SmxFaVcwdlVuM3k4bG9QTGVPZTFQbmM1WWtYLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VDg3ZTdTVWhvdkJqdkpsRWlXMHZVbjN5OGxvUExlT2UxUG5jNVlrWCxwPVFaQTlQVlRpU2VGelNQd25RMXlZWjRUNFY4YzBpdWZYVGhMcnpTUHBWWHc9</response>

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

2019-10-13 20:24:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:35 | [Mutex] received everything.

2019-10-13 20:24:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:35 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:35 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj15SEl2a1RGcnlJa05meUs4cG9OTA==</auth>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15SEl2a1RGcnlJa05meUs4cG9OTHdKRjJPb1hKSmZIOUNRTE5aeFYxLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eUhJdmtURnJ5SWtOZnlLOHBvTkx3SkYyT29YSkpmSDlDUUxOWnhWMSxwPWNvOUtGZXZScWt6RlpPb0UwL2txTCtYa0ZhTWNIN0NVSDM2Y0ZDdGhGVk09</response>

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

2019-10-13 20:24:36 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:36 | [Mutex] received everything.

2019-10-13 20:24:36 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:36 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1Yd3RmbXF4VDVrWDNGeVQ2OWxvcg==</auth>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Yd3RmbXF4VDVrWDNGeVQ2OWxvcnBlNGdOcWFXREpkWWFUU1E1bDZ0LHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WHd0Zm1xeFQ1a1gzRnlUNjlsb3JwZTRnTnFhV0RKZFlhVFNRNWw2dCxwPVo5RW5NVnQyU1ZLazl0QzdEUE1YNXZDczlMQ2dIQ1BHMjZmb2NvemN0aWM9</response>

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

2019-10-13 20:24:36 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:36 | [Mutex] notify: [event, disconnected]

2019-10-13 20:24:36 | [Mutex] received everything.

2019-10-13 20:24:36 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:36 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj13NEpiUVBRc3loc25wb2Q4YXZtUA==</auth>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13NEpiUVBRc3loc25wb2Q4YXZtUHBpTEt0b3VlbzJFZThweEVRaFQ2LHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dzRKYlFQUXN5aHNucG9kOGF2bVBwaUxLdG91ZW8yRWU4cHhFUWhUNixwPVNLcmVDc3ZoQWc0ZVU5bnRjNmFJVmxUMmJIdVczRjgvVDRFNEdmZHl1TWM9</response>

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

2019-10-13 20:24:36 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:36 | [Mutex] received everything.

2019-10-13 20:24:36 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:36 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1uVU9ONnVSRWZOSnZKRjgzNzdpQw==</auth>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uVU9ONnVSRWZOSnZKRjgzNzdpQ3NzVGVzeVpQYzM2cjM1N053VlBvLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9blVPTjZ1UkVmTkp2SkY4Mzc3aUNzc1Rlc3laUGMzNnIzNTdOd1ZQbyxwPW9Sb1V3cEZyQkxOamxnUVNRcGJ2cmQ2cHVrazlHK3VNdWhhajVGaFE2RkU9</response>

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

2019-10-13 20:24:36 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:36 | [Mutex] received everything.

2019-10-13 20:24:36 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:36 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1MOVFseFFKbEFYcUlzNkkwQTVXQg==</auth>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MOVFseFFKbEFYcUlzNkkwQTVXQmFYV2ZBa3RNbVFTOXVWQkVHMEtBLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TDlRbHhRSmxBWHFJczZJMEE1V0JhWFdmQWt0TW1RUzl1VkJFRzBLQSxwPTNmamlRakovNE9FQmxaSzh4bHRUTit5TGlTMjMyQU9QRk5wMUk4NDB3TFU9</response>

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

2019-10-13 20:24:36 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:36 | [Mutex] received everything.

2019-10-13 20:24:36 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:36 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj16ZlVQMmlKOWtMckNiOFFXeUI2dQ==</auth>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16ZlVQMmlKOWtMckNiOFFXeUI2dVpmZVZ3NWFrQzhCSjA2YWl2cllNLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9emZVUDJpSjlrTHJDYjhRV3lCNnVaZmVWdzVha0M4QkowNmFpdnJZTSxwPU84UWd5NU9xSUdrWk1qWmNJWlo5SXM5Y3pFbkN6cWVKS0ZGTHVhbjJQUEk9</response>

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

2019-10-13 20:24:36 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:36 | [Mutex] received everything.

2019-10-13 20:24:36 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:36 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1jamE4aDlBSjl2MmxrY3I4TVNldA==</auth>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jamE4aDlBSjl2MmxrY3I4TVNldG9laGJhUnZtV2JNQXJ3S3pZQzNKLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y2phOGg5QUo5djJsa2NyOE1TZXRvZWhiYVJ2bVdiTUFyd0t6WUMzSixwPU9ISjFoYXZ1N0lDZFVqS2szRFV2YWZEMjRZN2szWjRKeFh1dUZWa0JoUXM9</response>

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

2019-10-13 20:24:36 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:36 | [Mutex] received everything.

2019-10-13 20:24:36 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:36 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:36 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1rMDJpNzFhdldBZGtrbDY2V1c4QQ==</auth>

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rMDJpNzFhdldBZGtrbDY2V1c4QU96RTBiSm9VaHBPNUZhRWhCYjBNLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9azAyaTcxYXZXQWRra2w2NldXOEFPekUwYkpvVWhwTzVGYUVoQmIwTSxwPTAxSlk2bU1PdUhqZ2hnUUsyN1phd2tzQmV3eFNvTTBjZ1dGbW1BSHNKN0U9</response>

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

2019-10-13 20:24:37 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:37 | [Mutex] received everything.

2019-10-13 20:24:37 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:37 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1PbWRuY00zNWhsMmcwRHRyT3FXWQ==</auth>

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PbWRuY00zNWhsMmcwRHRyT3FXWWJ1eGpONWc3dmhKT0FhSlNwVHJxLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T21kbmNNMzVobDJnMER0ck9xV1lidXhqTjVnN3ZoSk9BYUpTcFRycSxwPS9zU0FOVnRyQmZVTVNublF5Y3FiQnRSTUZGTWUvUTRKVDFwUW42Tk8vNUE9</response>

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

2019-10-13 20:24:37 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:37 | [Mutex] received everything.

2019-10-13 20:24:37 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:37 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj16OEplN1l1V1AyOFBoVnJVR0dPQQ==</auth>

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16OEplN1l1V1AyOFBoVnJVR0dPQUNOeGxZWmhLR2VYd0p0aFZjckdrLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ejhKZTdZdVdQMjhQaFZyVUdHT0FDTnhsWVpoS0dlWHdKdGhWY3JHayxwPUw0TUowZHJNTEJ3dWpBdHRvVm5XUWY3OFh3blRQeVo3T1MxbUQ5QmlXNU09</response>

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

2019-10-13 20:24:37 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:37 | [Mutex] received everything.

2019-10-13 20:24:37 | [Mutex] isItemNotified: authFailed :: true

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

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzV3dGppejAwMTkscj1aRkRRYWQyQVU5aHp0dDRlM2tXcA==</auth>

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aRkRRYWQyQVU5aHp0dDRlM2tXcDNPdHNKWGJMMWFPTEc4aEVPaXVtLHM9anRBUngwSTFIL2I4TEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:37 | user :: user_5wtjiz0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WkZEUWFkMkFVOWh6dHQ0ZTNrV3AzT3RzSlhiTDFhT0xHOGhFT2l1bSxwPWJlUk5MM3g4cFJFTHAraDBaZ0kzWmtUcFlVZzdhZ2tYU2ZPWTJCYXp6M289</response>

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

2019-10-13 20:24:39 | [Mutex] waiting for: [user]

2019-10-13 20:24:39 | [Mutex] received everything.

2019-10-13 20:24:39 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.325s
2019-10-13 20:24:39 |

2019-10-13 20:24:39 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:24:39 | ------------------------------------

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1e023997

2019-10-13 20:24:39 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@10c5c427}, 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@14fa52e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@51f8ce1c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e399b35}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:39 PDT 2019}}}}

2019-10-13 20:24:39 | [Mutex] waiting for: [registration]

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@60639829

2019-10-13 20:24:39 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@10c5c427}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@14fa52e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@51f8ce1c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e399b35}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:39 PDT 2019}}}}

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@264893a8

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

2019-10-13 20:24:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31d73153}

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

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

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

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2325e46f

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5ffb92f2

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

2019-10-13 20:24:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3d4c9f76}

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

2019-10-13 20:24:39 | user :: null >> <iq to="localhost" id="dOYpZs4DrVUiECpdKGu06m6" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:24:39 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ea418135}

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

2019-10-13 20:24:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@35996c25}

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3993e065

2019-10-13 20:24:39 | user :: null >> <iq to="localhost" id="Gc6ndus5EspZ16Gqavp8s26" type="set"><query xmlns="jabber:iq:register"><username>user_gawiws0020</username><password>user_gawiws0020</password><email>40f678a5-e0cf-4c96-bd48-ce31a3a0c171@localhost</email></query></iq>

2019-10-13 20:24:39 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@35c7c808}

2019-10-13 20:24:39 | user :: null << <iq type="result" from="localhost" xmlns="jabber:client" id="Gc6ndus5EspZ16Gqavp8s26"/>

2019-10-13 20:24:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3a7c99a7}

2019-10-13 20:24:39 | [Mutex] received everything.

2019-10-13 20:24:39 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:24:39 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31d73153, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3d4c9f76]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@10c5c427}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@14fa52e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@51f8ce1c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e399b35}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:39 PDT 2019}}}}

2019-10-13 20:24:39 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31d73153, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3d4c9f76]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@10c5c427}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@14fa52e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@51f8ce1c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e399b35}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:39 PDT 2019}}}}

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@639206b1

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1d14b6a2

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3ba2edad

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@65cdfadf

2019-10-13 20:24:39 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1699cf59

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

2019-10-13 20:24:39 | user :: user_gawiws0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:39 | user :: user_gawiws0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2dhd2l3czAwMjAscj1uQldiTGZ0em5UQXZVTVMzcUJBWQ==</auth>

2019-10-13 20:24:39 | user :: user_gawiws0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uQldiTGZ0em5UQXZVTVMzcUJBWVRtelJCdnM4akRNdkRralFNcUlhLHM9QTlnTkVIcHJkaWFhOWc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:39 | user :: user_gawiws0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bkJXYkxmdHpuVEF2VU1TM3FCQVlUbXpSQnZzOGpETXZEa2pRTXFJYSxwPUhkVndtZ2REWW9kUDlFVHA1SWVaRjlIcDB6enVJOEFLZHI2cFdYYk5iRjA9</response>

2019-10-13 20:24:39 | user :: user_gawiws0020@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj05NjFxMkRqa3FvZHpxUEk5dmppTmtIallSRVNlQzNFbDdZRXBDMVpSUWIwPQ==</success>

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <iq xmlns="jabber:client" id="pXl4s6kGs4wsX2gWl7slSdu" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost << <iq type="result" xmlns="jabber:client" id="pXl4s6kGs4wsX2gWl7slSdu" to="user_gawiws0020@localhost/993927746-tigase-14"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_gawiws0020@localhost/993927746-tigase-14</jid></bind></iq>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost/993927746-tigase-14 >> <iq xmlns="jabber:client" id="ghhHTXXYqU8rhSW02aum8jK" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost/993927746-tigase-14 << <iq type="result" xmlns="jabber:client" id="ghhHTXXYqU8rhSW02aum8jK" to="user_gawiws0020@localhost/993927746-tigase-14"/>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost/993927746-tigase-14 >> <iq to="localhost" id="giiJX5dusYgHNU08iGwqgzg" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost/993927746-tigase-14 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost/993927746-tigase-14 << <enabled location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="8bf272be-5866-41b1-b811-7cd23df7f077" resume="true" max="60"/>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost/993927746-tigase-14 >> <iq id="uRXZ8EIt4k4BDup0t0u9MIV" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost/993927746-tigase-14 << <iq type="result" from="localhost" xmlns="jabber:client" id="giiJX5dusYgHNU08iGwqgzg" to="user_gawiws0020@localhost/993927746-tigase-14"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field 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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost/993927746-tigase-14 << <iq type="result" xmlns="jabber:client" id="uRXZ8EIt4k4BDup0t0u9MIV" to="user_gawiws0020@localhost/993927746-tigase-14"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:24:40 | Disconnecting

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

2019-10-13 20:24:40 | [Mutex] notify: [disconnected]

2019-10-13 20:24:40 | [Mutex] received everything.

2019-10-13 20:24:40 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2dhd2l3czAwMjAscj1YdnQ0QUJvMkxxZEFQQ2h6N2tuUQ==</auth>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YdnQ0QUJvMkxxZEFQQ2h6N2tuUWJjb3lOcmZpSlFsVlR3SHhqUGRQLHM9QTlnTkVIcHJkaWFhOWc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WHZ0NEFCbzJMcWRBUENoejdrblFiY295TnJmaUpRbFZUd0h4alBkUCxwPWlFckp0OFFsR3VoYzhVdFhGbUgydVJuTXVyM1p0cUI2cktuaTlWa0NjVU09</response>

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

2019-10-13 20:24:40 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:40 | [Mutex] notify: [event, disconnected]

2019-10-13 20:24:40 | [Mutex] received everything.

2019-10-13 20:24:40 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:40 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2dhd2l3czAwMjAscj1NRGFKSFVKZ1JyTmlJblF2TGVyQQ==</auth>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NRGFKSFVKZ1JyTmlJblF2TGVyQVZFTjVMSVQ3c0tUdkpmaG41M0R0LHM9QTlnTkVIcHJkaWFhOWc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TURhSkhVSmdSck5pSW5RdkxlckFWRU41TElUN3NLVHZKZmhuNTNEdCxwPWRvVERBZ3AxSG1SN2FldVZBenJmb1g3M1lRTUZTSVpESVBWclhqZXUra2M9</response>

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

2019-10-13 20:24:40 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:40 | [Mutex] received everything.

2019-10-13 20:24:40 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:40 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2dhd2l3czAwMjAscj15anVNblJJMUVRckprbkt2dTFnSg==</auth>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15anVNblJJMUVRckprbkt2dTFnSkZNZlpLcTc2YzFYcDcxTVRXU3lWLHM9QTlnTkVIcHJkaWFhOWc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eWp1TW5SSTFFUXJKa25LdnUxZ0pGTWZaS3E3NmMxWHA3MU1UV1N5VixwPTd3Y3h1NXBFWGNDT3UvbThsQjZ2NnE3bG91ckRxRTRBZE1NS3J6Z3FlQnM9</response>

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

2019-10-13 20:24:40 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:40 | [Mutex] received everything.

2019-10-13 20:24:40 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:40 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2dhd2l3czAwMjAscj0zbEdyNGhOWFAxMHV5ZmZmRVN5VA==</auth>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zbEdyNGhOWFAxMHV5ZmZmRVN5VEEyNVBRRVRCOEdDaWZ3Tk10SmF0LHM9QTlnTkVIcHJkaWFhOWc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M2xHcjRoTlhQMTB1eWZmZkVTeVRBMjVQUUVUQjhHQ2lmd05NdEphdCxwPW1GWXpUdmpPcWVwcjRvVTU1bjB6MS9MMGVWaGZ4b1ltbHBGL1pkbWZqTms9</response>

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

2019-10-13 20:24:40 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:40 | [Mutex] notify: [event, disconnected]

2019-10-13 20:24:40 | [Mutex] received everything.

2019-10-13 20:24:40 | [Mutex] isItemNotified: authFailed :: true

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2dhd2l3czAwMjAscj1VVFZYNks5N01xWnY0MkVYM2dLaQ==</auth>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VVFZYNks5N01xWnY0MkVYM2dLaXRraTVzUHpoNVpYVkUyczNHV0FQLHM9QTlnTkVIcHJkaWFhOWc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:40 | user :: user_gawiws0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VVRWWDZLOTdNcVp2NDJFWDNnS2l0a2k1c1B6aDVaWFZFMnMzR1dBUCxwPWRkQnp0b2s1MUJuNUZ6TnF6SURJZ3hzZlZJcW1aQ0RPaU0xZjg1cVl5QVE9</response>

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

2019-10-13 20:24:42 | [Mutex] waiting for: [user]

2019-10-13 20:24:42 | [Mutex] received everything.

2019-10-13 20:24:42 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.347s
2019-10-13 20:24:42 |

2019-10-13 20:24:42 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:24:42 | ------------------------------------

2019-10-13 20:24:42 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4c739cdc

2019-10-13 20:24:42 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@42b47b22}, 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@468bf7ac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3897119}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@534c98c8}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:42 PDT 2019}}}}

2019-10-13 20:24:42 | [Mutex] waiting for: [registration]

2019-10-13 20:24:42 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@32c094e8

2019-10-13 20:24:42 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@42b47b22}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@468bf7ac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3897119}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@534c98c8}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:42 PDT 2019}}}}

2019-10-13 20:24:42 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2bef238b

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

2019-10-13 20:24:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@63a68e56}

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

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

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

2019-10-13 20:24:42 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@541bc032

2019-10-13 20:24:42 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@62ca698d

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

2019-10-13 20:24:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@30ebed24}

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

2019-10-13 20:24:43 | user :: null >> <iq to="localhost" id="ajdBFogHSUjNDk8kY7DAmQI" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:24:43 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c28ab2ef}

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

2019-10-13 20:24:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@67e81151}

2019-10-13 20:24:43 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6df857ce

2019-10-13 20:24:43 | user :: null >> <iq to="localhost" id="55vphZcPQ9mczCohJv4CiUZ" type="set"><query xmlns="jabber:iq:register"><username>user_nx8kkt0021</username><password>user_nx8kkt0021</password><email>1b793c72-3db8-4458-809b-3adedf4d513b@localhost</email></query></iq>

2019-10-13 20:24:43 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@42cf8d79}

2019-10-13 20:24:43 | user :: null << <iq type="result" from="localhost" xmlns="jabber:client" id="55vphZcPQ9mczCohJv4CiUZ"/>

2019-10-13 20:24:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5c4fddfd}

2019-10-13 20:24:43 | [Mutex] received everything.

2019-10-13 20:24:43 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:24:43 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@63a68e56, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@30ebed24]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@42b47b22}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@468bf7ac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3897119}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@534c98c8}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:43 PDT 2019}}}}

2019-10-13 20:24:43 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@63a68e56, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@30ebed24]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@42b47b22}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@468bf7ac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3897119}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@534c98c8}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:43 PDT 2019}}}}

2019-10-13 20:24:43 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3322999d

2019-10-13 20:24:43 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@14677431

2019-10-13 20:24:43 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3b8e0754

2019-10-13 20:24:43 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@190c95ed

2019-10-13 20:24:43 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3e450920

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX254OGtrdDAwMjEscj14THFTVzBkNTFtTmlIaHRudTcwUw==</auth>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14THFTVzBkNTFtTmlIaHRudTcwU243c3ZIa1JsMmZpZDE2U1VnV0R3LHM9VnYyQ2g4K2dQK2ZGbFE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eExxU1cwZDUxbU5pSGh0bnU3MFNuN3N2SGtSbDJmaWQxNlNVZ1dEdyxwPVdFWXNrdzVGenU3a2sxckEyanpNeDRUUmF0Qk5iSnhUQythMUJCeG9USFE9</response>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1WSnJrbEpscmFFeERCeXZ4M1E3MFZHYkRjMEpFTzhlOXN2WFNLTW51Z0dZPQ==</success>

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <iq xmlns="jabber:client" id="P5tY0u2oXjW4gycyuoPMKUh" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost << <iq type="result" xmlns="jabber:client" id="P5tY0u2oXjW4gycyuoPMKUh" to="user_nx8kkt0021@localhost/993927746-tigase-15"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_nx8kkt0021@localhost/993927746-tigase-15</jid></bind></iq>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost/993927746-tigase-15 >> <iq xmlns="jabber:client" id="gppXpZ16Gqavp8s26iKSanS" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost/993927746-tigase-15 << <iq type="result" xmlns="jabber:client" id="gppXpZ16Gqavp8s26iKSanS" to="user_nx8kkt0021@localhost/993927746-tigase-15"/>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost/993927746-tigase-15 >> <iq to="localhost" id="qlbFwamOMWiDoYmbNO3i3aO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost/993927746-tigase-15 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost/993927746-tigase-15 << <enabled location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="f23fdc14-34eb-4843-82a6-e35ec4c0df27" resume="true" max="60"/>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost/993927746-tigase-15 >> <iq id="b9zAeW3Ak9tZ2yaEtl0cw4e" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost/993927746-tigase-15 << <iq type="result" from="localhost" xmlns="jabber:client" id="qlbFwamOMWiDoYmbNO3i3aO" to="user_nx8kkt0021@localhost/993927746-tigase-15"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field 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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost/993927746-tigase-15 << <iq type="result" xmlns="jabber:client" id="b9zAeW3Ak9tZ2yaEtl0cw4e" to="user_nx8kkt0021@localhost/993927746-tigase-15"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:24:43 | Disconnecting

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

2019-10-13 20:24:43 | [Mutex] notify: [disconnected]

2019-10-13 20:24:43 | [Mutex] received everything.

2019-10-13 20:24:43 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX254OGtrdDAwMjEscj1SbjNUck9sNFpjSjhzZ2hwOUpiUA==</auth>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SbjNUck9sNFpjSjhzZ2hwOUpiUGlKaGtncEJlbkp3M0ZTYVdNUzUxLHM9VnYyQ2g4K2dQK2ZGbFE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Um4zVHJPbDRaY0o4c2docDlKYlBpSmhrZ3BCZW5KdzNGU2FXTVM1MSxwPUFpZGFwa21xTVBzTzhha2JoSU42YkRSQ1NyTlVmRzR0SmdBY1FLU1ZmYWM9</response>

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

2019-10-13 20:24:43 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:43 | [Mutex] notify: [event, disconnected]

2019-10-13 20:24:43 | [Mutex] received everything.

2019-10-13 20:24:43 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:43 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfbng4a2t0MDAyMQAgLSAtIC0gLSAt</auth>

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

2019-10-13 20:24:43 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:43 | [Mutex] received everything.

2019-10-13 20:24:43 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:43 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX254OGtrdDAwMjEscj1VUG1iaWRkSUJGYjI1QUlVZ1lUYQ==</auth>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VUG1iaWRkSUJGYjI1QUlVZ1lUYVpFMGdFOFdPYnBsdEhTOGhtTzJNLHM9VnYyQ2g4K2dQK2ZGbFE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VVBtYmlkZElCRmIyNUFJVWdZVGFaRTBnRThXT2JwbHRIUzhobU8yTSxwPVZOazFTUCtac2hScVQwYmNrRlk1MGhCQkJIVVkvNmtaMGFlaS85M1liN0k9</response>

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

2019-10-13 20:24:43 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:43 | [Mutex] received everything.

2019-10-13 20:24:43 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:43 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:43 | user :: user_nx8kkt0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:44 | user :: user_nx8kkt0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX254OGtrdDAwMjEscj1YVFVlaUlreDVCU3NtUlFuS3BLNQ==</auth>

2019-10-13 20:24:44 | user :: user_nx8kkt0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YVFVlaUlreDVCU3NtUlFuS3BLNWtoWFhSNlYzanFhU1NGYXZqZHVqLHM9eWptNUYxalFscytxcVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:44 | user :: user_nx8kkt0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WFRVZWlJa3g1QlNzbVJRbktwSzVraFhYUjZWM2pxYVNTRmF2amR1aixwPXg3MTR2RXdPY2IyMnNtOEpaZWtmS3d4ZEJ4WT0=</response>

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

2019-10-13 20:24:44 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:44 | [Mutex] received everything.

2019-10-13 20:24:44 | [Mutex] isItemNotified: authFailed :: true

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

2019-10-13 20:24:44 | user :: user_nx8kkt0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:44 | user :: user_nx8kkt0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX254OGtrdDAwMjEscj1xTE83TVU5dE84THNHVHY5Y3IxTw==</auth>

2019-10-13 20:24:44 | user :: user_nx8kkt0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xTE83TVU5dE84THNHVHY5Y3IxT3pvVjBPWnlhbTlHZFdFWktuZ1RoLHM9VnYyQ2g4K2dQK2ZGbFE9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:44 | user :: user_nx8kkt0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cUxPN01VOXRPOExzR1R2OWNyMU96b1YwT1p5YW05R2RXRVpLbmdUaCxwPTVSVi9iNThrNlJaMnlpajZGMDNuRFgxU3lXWnRuY1RBVFUrdUtjRzZzZmM9</response>

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

2019-10-13 20:24:46 | [Mutex] waiting for: [user]

2019-10-13 20:24:46 | [Mutex] received everything.

2019-10-13 20:24:46 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.075s
2019-10-13 20:24:46 |

2019-10-13 20:24:46 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:24:46 | ------------------------------------

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7173117

2019-10-13 20:24:46 | [Mutex] waiting for: [registration]

2019-10-13 20:24:46 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@9d0cf85}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@def5a67}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48edc5be}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@76ccca3d}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:46 PDT 2019}}}}

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@796f8f86

2019-10-13 20:24:46 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@9d0cf85}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@def5a67}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48edc5be}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@76ccca3d}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:46 PDT 2019}}}}

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@ea4deae

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

2019-10-13 20:24:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@28c23af1}

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

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

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

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@384f80f6

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3d592bc6

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

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

2019-10-13 20:24:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@15a0d36d}

2019-10-13 20:24:46 | user :: null >> <iq to="localhost" id="GrlRbqkP8qlRLAEm2fT6oUQ" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:24:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c1d4a214}

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

2019-10-13 20:24:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2c8c669a}

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@68800bcd

2019-10-13 20:24:46 | user :: null >> <iq to="localhost" id="PcBdusYgHNU08iGwqgzgIQ9" type="set"><query xmlns="jabber:iq:register"><username>user_ha3kfe0022</username><password>user_ha3kfe0022</password><email>067b500e-75fb-4b4c-a023-82307395a76d@localhost</email></query></iq>

2019-10-13 20:24:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@514a73d0}

2019-10-13 20:24:46 | user :: null << <iq type="result" from="localhost" xmlns="jabber:client" id="PcBdusYgHNU08iGwqgzgIQ9"/>

2019-10-13 20:24:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1c730a00}

2019-10-13 20:24:46 | [Mutex] received everything.

2019-10-13 20:24:46 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:24:46 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@28c23af1, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@15a0d36d]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@9d0cf85}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@def5a67}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48edc5be}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@76ccca3d}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:46 PDT 2019}}}}

2019-10-13 20:24:46 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@68c96b7b}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@28c23af1, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@15a0d36d]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@9d0cf85}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2d45f0d1}, 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@def5a67}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48edc5be}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@76ccca3d}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:24:46 PDT 2019}}}}

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@fdb8958

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@40ac968f

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@289a2334

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2c3d1f2d

2019-10-13 20:24:46 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7fffc2bb

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

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hhM2tmZTAwMjIscj1LcURsNU12RU9SeTB1eDBSbUFGQw==</auth>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LcURsNU12RU9SeTB1eDBSbUFGQ09HWjNCU1dGZmdZa1BlSEdJRzRYLHM9TFBFS3FzU2ZPYnZlenc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S3FEbDVNdkVPUnkwdXgwUm1BRkNPR1ozQlNXRmZnWWtQZUhHSUc0WCxwPTBxejJrc2paUTlFRmtzVkpiR1JoMCt2TFhnaTlBeEhLakZzRDd2K2FMQ0k9</response>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1sV0oxU2FNNkgzRjcxazFJRTBLRnd2NFdhY0N3WHgxTlJTZzgweW1ic0kwPQ==</success>

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

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost >> <iq xmlns="jabber:client" id="1qfSNICELX8HADk8rmSfFnO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost << <iq type="result" xmlns="jabber:client" id="1qfSNICELX8HADk8rmSfFnO" to="user_ha3kfe0022@localhost/993927746-tigase-16"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_ha3kfe0022@localhost/993927746-tigase-16</jid></bind></iq>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost/993927746-tigase-16 >> <iq xmlns="jabber:client" id="Abu8GP5odCHsoXoWnVTQao6" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost/993927746-tigase-16 << <iq type="result" xmlns="jabber:client" id="Abu8GP5odCHsoXoWnVTQao6" to="user_ha3kfe0022@localhost/993927746-tigase-16"/>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost/993927746-tigase-16 >> <iq to="localhost" id="eyzh2eX5dusYgHNU08iGwqg" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost/993927746-tigase-16 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost/993927746-tigase-16 << <enabled location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="34bdc958-944c-4c6e-8f8a-37b69ad860ee" resume="true" max="60"/>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost/993927746-tigase-16 >> <iq id="pgFHICmKAk2u1awsnbABofy" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost/993927746-tigase-16 << <iq type="result" from="localhost" xmlns="jabber:client" id="eyzh2eX5dusYgHNU08iGwqg" to="user_ha3kfe0022@localhost/993927746-tigase-16"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field 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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost/993927746-tigase-16 << <iq type="result" xmlns="jabber:client" id="pgFHICmKAk2u1awsnbABofy" to="user_ha3kfe0022@localhost/993927746-tigase-16"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:24:46 | Disconnecting

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

2019-10-13 20:24:46 | [Mutex] notify: [disconnected]

2019-10-13 20:24:46 | [Mutex] received everything.

2019-10-13 20:24:46 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hhM2tmZTAwMjIscj1pV0t3dXh2Tm9DSUVIZG9ybFR1UA==</auth>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pV0t3dXh2Tm9DSUVIZG9ybFR1UGcyaXI5WGZrUEM1VllubFNGa2JDLHM9TFBFS3FzU2ZPYnZlenc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aVdLd3V4dk5vQ0lFSGRvcmxUdVBnMmlyOVhma1BDNVZZbmxTRmtiQyxwPWRJU3gzVUpUaEU4dHM4TFVjOEVWNGYvZlhrSk0yYUhscVNKR3FSZmc4ZDA9</response>

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

2019-10-13 20:24:46 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:46 | [Mutex] received everything.

2019-10-13 20:24:46 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:46 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:46 | user :: user_ha3kfe0022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hhM2tmZTAwMjIscj12RUxZb0JLMDFDZkVrMWFqUmNxcQ==</auth>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12RUxZb0JLMDFDZkVrMWFqUmNxcUYyeGpZUVQwOWVmb1lpNjlCRDZZLHM9TFBFS3FzU2ZPYnZlenc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dkVMWW9CSzAxQ2ZFazFhalJjcXFGMnhqWVFUMDllZm9ZaTY5QkQ2WSxwPUpKRzdjbHZYYm83ZnpQVWlucVE4bVVlSk9yZko1RnAzcURRVlgxb3plVm89</response>

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

2019-10-13 20:24:47 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:47 | [Mutex] received everything.

2019-10-13 20:24:47 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:24:47 | [Mutex] waiting for: [event]

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

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hhM2tmZTAwMjIscj1OblM0T09uYWpYZmhLeE5KWWpTVw==</auth>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OblM0T09uYWpYZmhLeE5KWWpTV09wSmgwNThqdlhIa2huWVg5dGFsLHM9TFBFS3FzU2ZPYnZlenc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Tm5TNE9PbmFqWGZoS3hOSllqU1dPcEpoMDU4anZYSGtobllYOXRhbCxwPXJqbGNkNmZJR0RBNHhXbStDRnVzOEZTUGd3UjR2MkIvb09veEJaVjJORkU9</response>

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

2019-10-13 20:24:47 | [Mutex] notify: [event, authFailed]

2019-10-13 20:24:47 | [Mutex] received everything.

2019-10-13 20:24:47 | [Mutex] isItemNotified: authFailed :: true

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

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hhM2tmZTAwMjIscj14WWVTZzZwb0g5V3pvZm1jYkVjMQ==</auth>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14WWVTZzZwb0g5V3pvZm1jYkVjMU1BM3V5ZzFUeUhCMVI4SEZlMDRjLHM9TFBFS3FzU2ZPYnZlenc9PSxpPTQwOTY=</challenge>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eFllU2c2cG9IOVd6b2ZtY2JFYzFNQTN1eWcxVHlIQjFSOEhGZTA0YyxwPXlRMTAzY0dxT2hIUThoL2M3TjdRUENJajl6MGdackQ1T05WNjd4N1lsQk09</response>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj05STVHUkt6L2hOWXZJeU1PZkgvM1hMOEREQ2NBWWtmVmJweUJHWXdkQjZvPQ==</success>

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

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost >> <iq xmlns="jabber:client" id="wgDCElOO2xveTYpSeDKENLz" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost << <iq type="result" xmlns="jabber:client" id="wgDCElOO2xveTYpSeDKENLz" to="user_ha3kfe0022@localhost/993927746-tigase-17"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_ha3kfe0022@localhost/993927746-tigase-17</jid></bind></iq>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost/993927746-tigase-17 >> <iq xmlns="jabber:client" id="DAzxi1eVUiL0aPPHsoQ0bLQ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost/993927746-tigase-17 << <iq type="result" xmlns="jabber:client" id="DAzxi1eVUiL0aPPHsoQ0bLQ" to="user_ha3kfe0022@localhost/993927746-tigase-17"/>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost/993927746-tigase-17 >> <iq to="localhost" id="PjIrWmMSVfOOKw8qeSNICEL" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost/993927746-tigase-17 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost/993927746-tigase-17 >> <iq id="8AvcPQ9mczCohJv4CiUZn4k" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost/993927746-tigase-17 << <enabled location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="3fb37469-3253-4770-a296-e81d33279163" resume="true" max="60"/>

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost/993927746-tigase-17 << <iq type="result" xmlns="jabber:client" id="8AvcPQ9mczCohJv4CiUZn4k" to="user_ha3kfe0022@localhost/993927746-tigase-17"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:24:47 | Disconnecting

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

2019-10-13 20:24:47 | user :: user_ha3kfe0022@localhost/993927746-tigase-17 << <iq type="result" from="localhost" xmlns="jabber:client" id="PjIrWmMSVfOOKw8qeSNICEL" to="user_ha3kfe0022@localhost/993927746-tigase-17"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field 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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-10-13 20:24:47 | [Mutex] notify: [disconnected]

2019-10-13 20:24:47 | [Mutex] received everything.

2019-10-13 20:24:49 | [Mutex] waiting for: [user]

2019-10-13 20:24:49 | [Mutex] received everything.

2019-10-13 20:24:49 | [Mutex] isItemNotified: user:ok:true :: true