Brute Force Prevention

2019-12-03 20:25:13 |

2019-12-03 20:25:13 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-12-03 20:25:13 | ------------------------------------

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@79ad3948

2019-12-03 20:25:13 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@776ac80d}, 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@73555238}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3657c236}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2620cacd}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:13 PST 2019}}}}

2019-12-03 20:25:13 | [Mutex] waiting for: [registration]

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7ab54a4

2019-12-03 20:25:13 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@776ac80d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@73555238}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3657c236}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2620cacd}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:13 PST 2019}}}}

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@5e3602fb

2019-12-03 20:25:13 | 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-12-03 20:25:13 | 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-12-03 20:25:13 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@56783d79}

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

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

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@76aee3d9

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2bfd87dc

2019-12-03 20:25:13 | 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-12-03 20:25:13 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@45326982}

2019-12-03 20:25:13 | 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-12-03 20:25:13 | user :: null >> <iq to="localhost" id="sSTTOHtZ8nSZ9AFCi1cScBc" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-12-03 20:25:13 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@758ac3bd}

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

2019-12-03 20:25:13 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@523607a8}

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5307861c

2019-12-03 20:25:13 | user :: null >> <iq to="localhost" id="VROPIUXWXZ1cv8vbENSO3g0" type="set"><query xmlns="jabber:iq:register"><username>user_kljwc10027</username><password>user_kljwc10027</password><email>0458e663-c91e-49ba-aec7-68edf5cff89e@localhost</email></query></iq>

2019-12-03 20:25:13 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1f7f2cab}

2019-12-03 20:25:13 | user :: null << <iq xmlns="jabber:client" id="VROPIUXWXZ1cv8vbENSO3g0" from="localhost" type="result"/>

2019-12-03 20:25:13 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@148328c7}

2019-12-03 20:25:13 | [Mutex] received everything.

2019-12-03 20:25:13 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-03 20:25:13 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@56783d79, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@45326982]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@776ac80d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@73555238}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3657c236}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2620cacd}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:13 PST 2019}}}}

2019-12-03 20:25:13 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@56783d79, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@45326982]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@776ac80d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@73555238}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3657c236}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2620cacd}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:13 PST 2019}}}}

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@422b2dac

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@20427906

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4f1a3c74

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@42d2f040

2019-12-03 20:25:13 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@590fe3fb

2019-12-03 20:25:13 | user :: user_kljwc10027@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-12-03 20:25:13 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:13 | user :: user_kljwc10027@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-12-03 20:25:13 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1DSXVUd2RxNmxNVVZidzQwZGUwYg==</auth>

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DSXVUd2RxNmxNVVZidzQwZGUwYkF3Z2tsMFRLWlRXbEFOR0JmS0VQLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q0l1VHdkcTZsTVVWYnc0MGRlMGJBd2drbDBUS1pUV2xBTkdCZktFUCxwPVNXN1YraHRZRGtWUVB3RFU3VWVXWUpvaStqUXNSKzVKblVObzQ4cHJiT009</response>

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1hbjc0QS83Y25vQmk1bWlKZEFWQ0Vnbm9LVTJoSVJ3MGh4YUNSQnpjbjRRPQ==</success>

2019-12-03 20:25:13 | user :: user_kljwc10027@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 hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="tayVLFeRarzqpIYlhM87XxlAcgo="/></features>

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost >> <iq xmlns="jabber:client" id="lLu9rfW7i4hAfzbw9q5lYra" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="5GdzqlY0r2yyjCHN17zlP1u" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" id="5GdzqlY0r2yyjCHN17zlP1u" type="result" to="user_kljwc10027@localhost/993927746-tigase-19"/>

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

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

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost/993927746-tigase-19 << <enabled xmlns="urn:xmpp:sm:3" max="60" id="2d9cc3a4-4fe7-4648-adc2-30525d9acb8c" resume="true" location="d4270859fb27"/>

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost/993927746-tigase-19 >> <iq id="OSJRNV3fRazcSTOHtZ8nSZ9" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" id="rwHQPGrXX4fCt7wxmMZ8KW5" from="localhost" type="result" to="user_kljwc10027@localhost/993927746-tigase-19"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="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="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

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

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" id="OSJRNV3fRazcSTOHtZ8nSZ9" type="result" to="user_kljwc10027@localhost/993927746-tigase-19"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 20:25:13 | Disconnecting

2019-12-03 20:25:13 | [Mutex] notify: [disconnected]

2019-12-03 20:25:13 | [Mutex] received everything.

2019-12-03 20:25:13 | [Mutex] waiting for: [event]

2019-12-03 20:25:13 | user :: user_kljwc10027@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-12-03 20:25:13 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:13 | user :: user_kljwc10027@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-12-03 20:25:13 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1iTTJ3b2ZTd3FDajV5MzVsMFFTYg==</auth>

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iTTJ3b2ZTd3FDajV5MzVsMFFTYm1IdXpjOXBkNjdUa3pJc3VQMkVpLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Yk0yd29mU3dxQ2o1eTM1bDBRU2JtSHV6YzlwZDY3VGt6SXN1UDJFaSxwPVk5WTdzcFlyeGkwLy9tNGR6SlBucERPL2IyeHVjOVA1SThVR2owa3VGUTQ9</response>

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

2019-12-03 20:25:13 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:13 | [Mutex] received everything.

2019-12-03 20:25:13 | [Mutex] notify: [event, disconnected]

2019-12-03 20:25:13 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:13 | [Mutex] waiting for: [event]

2019-12-03 20:25:13 | user :: user_kljwc10027@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-12-03 20:25:13 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:13 | user :: user_kljwc10027@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-12-03 20:25:13 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1PMmd1YjNMcjZPaUhzMFNPc1hoMQ==</auth>

2019-12-03 20:25:13 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PMmd1YjNMcjZPaUhzMFNPc1hoMXV3bnY3eEcwUjJ0cmRLYnVTZ0JZLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TzJndWIzTHI2T2lIczBTT3NYaDF1d252N3hHMFIydHJkS2J1U2dCWSxwPWZvamF2N1pmTy94WjVRSkowZm9kcXNNUXgwWllqV1VFTzk3UEJMaEttcnc9</response>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:14 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:14 | [Mutex] received everything.

2019-12-03 20:25:14 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:14 | [Mutex] waiting for: [event]

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1JVFBWcUZudTFIV3F2ck1icmtVZA==</auth>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JVFBWcUZudTFIV3F2ck1icmtVZHllcUhhMWpsNnBwWjQ0VmFOQld2LHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SVRQVnFGbnUxSFdxdnJNYnJrVWR5ZXFIYTFqbDZwcFo0NFZhTkJXdixwPXN1cm9JUXJnMkJHYzIyRWdHWm8yaFlFY3gxQ3laUFFpeW5xSmNZY3p3TXM9</response>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:14 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:14 | [Mutex] received everything.

2019-12-03 20:25:14 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:14 | [Mutex] waiting for: [event]

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1mRE9Bd2dvNXNlSmtIT2pkOTEzWg==</auth>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mRE9Bd2dvNXNlSmtIT2pkOTEzWkphSzBSOVFwSE5UUWZxaGFTT1lULHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZkRPQXdnbzVzZUprSE9qZDkxM1pKYUswUjlRcEhOVFFmcWhhU09ZVCxwPWtZVlJqam94ZXFoMnhubG4wQVNjM0RYcHVOclppUTFaOHNHeE85Yi9HOTQ9</response>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:14 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:14 | [Mutex] notify: [event, disconnected]

2019-12-03 20:25:14 | [Mutex] received everything.

2019-12-03 20:25:14 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:14 | [Mutex] waiting for: [event]

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1uZUpTcUx0UmdFamdicldGTHR0Nw==</auth>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uZUpTcUx0UmdFamdicldGTHR0N1VvcmprZlZvVmZoSlVEV3lTUjFILHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bmVKU3FMdFJnRWpnYnJXRkx0dDdVb3Jqa2ZWb1ZmaEpVRFd5U1IxSCxwPXpPbTRhOThwRjBVMlI0bWVOT2Uxc0RBK243dFoxNmR1UFZDWmE0VkRkR009</response>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:14 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:14 | [Mutex] received everything.

2019-12-03 20:25:14 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:14 | [Mutex] waiting for: [event]

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1sTTR3Ym02SWZZWXQxTWxxZ3JXWA==</auth>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sTTR3Ym02SWZZWXQxTWxxZ3JXWHZSMDBxaFRMQ1NNR3FvdmxzVjBSLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bE00d2JtNklmWVl0MU1scWdyV1h2UjAwcWhUTENTTUdxb3Zsc1YwUixwPTIzMnQyY1kzUmQ4amdSVnF5U1Z3WlorQkVPVEZrSmY0cTdHdEJoRW0vM1E9</response>

2019-12-03 20:25:14 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:14 | [Mutex] received everything.

2019-12-03 20:25:14 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:14 | [Mutex] waiting for: [event]

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj15TmFPeXlia3BFdktrUk5GUnRqVw==</auth>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15TmFPeXlia3BFdktrUk5GUnRqVzRQb2dJVHJNQ3hRWmhzTWhvY0JNLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eU5hT3l5YmtwRXZLa1JORlJ0alc0UG9nSVRyTUN4UVpoc01ob2NCTSxwPXQ1KzdOTnpSeTdGWVU3RnkyK21td3YzMitLSEx1QkJJSW8vak1kaW1pam89</response>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:14 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:14 | [Mutex] received everything.

2019-12-03 20:25:14 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:14 | [Mutex] waiting for: [event]

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj00cktUM21VTm4zSEZkclRzeTUzUQ==</auth>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00cktUM21VTm4zSEZkclRzeTUzUXRrUDN6eGdrZ1FaUFgxSHZlNEZnLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NHJLVDNtVU5uM0hGZHJUc3k1M1F0a1Azenhna2dRWlBYMUh2ZTRGZyxwPWQ2TVNRbDRGc0NJUVJwNURnQU1BYzZ5UWNSRzFqL2N5NjBzcU8zWUdEUHM9</response>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:14 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:14 | [Mutex] received everything.

2019-12-03 20:25:14 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:14 | [Mutex] waiting for: [event]

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1ySmlON0VaV2FpVHBrdU02ZlRTSQ==</auth>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ySmlON0VaV2FpVHBrdU02ZlRTSXZEUG13UWlWbEhJdk1jWWt5RkR5LHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ckppTjdFWldhaVRwa3VNNmZUU0l2RFBtd1FpVmxISXZNY1lreUZEeSxwPTFLLzB6NDhqaFJMeUFNNVlRR3lnRlhJc2g0eW1OTTN1cXRld1FxMHNlZ1U9</response>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:14 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:14 | [Mutex] received everything.

2019-12-03 20:25:14 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:14 | [Mutex] waiting for: [event]

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1wRDRDQkRGbUZaYVFaSTRWblRUbA==</auth>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wRDRDQkRGbUZaYVFaSTRWblRUbGpvWlFOalMzMEo3d21wcmt6UURhLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cEQ0Q0JERm1GWmFRWkk0Vm5UVGxqb1pRTmpTMzBKN3dtcHJrelFEYSxwPWVwNnkwbDBHRWNYNlEyS0x4ZXZVaU5PWG56SUJFdFRFd1hybE1MZEJHMUU9</response>

2019-12-03 20:25:14 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:14 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:14 | [Mutex] received everything.

2019-12-03 20:25:14 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:14 | [Mutex] waiting for: [event]

2019-12-03 20:25:14 | user :: user_kljwc10027@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-12-03 20:25:14 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1YZFRlSVc4V1N2UEs1d251cXhXRg==</auth>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YZFRlSVc4V1N2UEs1d251cXhXRlZhcmxVQjRmTGZlMHRwTDRhWmlZLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WGRUZUlXOFdTdlBLNXdudXF4V0ZWYXJsVUI0ZkxmZTB0cEw0YVppWSxwPXkyQWZyMWliWXFYdDdNVmsxeVRnbkxnS3d2QlNCMGlkR3FVUUpnK1JzME09</response>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:15 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:15 | [Mutex] received everything.

2019-12-03 20:25:15 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:15 | [Mutex] waiting for: [event]

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1uZVpsYnZ6RUhGd0lVenBzbEhJMw==</auth>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uZVpsYnZ6RUhGd0lVenBzbEhJM1FhM2RiV1Z0SDRYNHg5R1l2SjliLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bmVabGJ2ekVIRndJVXpwc2xISTNRYTNkYldWdEg0WDR4OUdZdko5YixwPTBJeHlvVTZzaDlUWjFmbHI3d20rUmQ4UE53dWpDRUM2MGVFT2dPSWZSekE9</response>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:15 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:15 | [Mutex] received everything.

2019-12-03 20:25:15 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:15 | [Mutex] waiting for: [event]

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1XU2pSQ1FCTlB1VWNtdkdIWU9SMQ==</auth>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XU2pSQ1FCTlB1VWNtdkdIWU9SMWNPb1VDQlcza2xKUUp2VlNhS0tFLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V1NqUkNRQk5QdVVjbXZHSFlPUjFjT29VQ0JXM2tsSlFKdlZTYUtLRSxwPTJmRmZNdVZKbUFKRHdsTWp3QWdoUDg2OG9qL0ZRZFM0Qjd3cDZXMFJVSlU9</response>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:15 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:15 | [Mutex] received everything.

2019-12-03 20:25:15 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:15 | [Mutex] notify: [event, disconnected]

2019-12-03 20:25:15 | [Mutex] waiting for: [event]

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj0wSUVSM09jcnNRcTc1OGtSbUhQMw==</auth>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wSUVSM09jcnNRcTc1OGtSbUhQM1gzbkJhQXN1dzNPd3FVcmM5b0E0LHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MElFUjNPY3JzUXE3NThrUm1IUDNYM25CYUFzdXczT3dxVXJjOW9BNCxwPXpmRk5tTVhrSFRmcVNSMWhzS3hEM3hoZkdqM0E5Y0RCZ0J3ZGFOSGlEdjg9</response>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:15 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:15 | [Mutex] received everything.

2019-12-03 20:25:15 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:15 | [Mutex] waiting for: [event]

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1XWnlXemZmMmVZVVVxSzk3SjRaNg==</auth>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XWnlXemZmMmVZVVVxSzk3SjRaNjBaMGxiZXNQdFpyTDRya3RqY1dKLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V1p5V3pmZjJlWVVVcUs5N0o0WjYwWjBsYmVzUHRackw0cmt0amNXSixwPVNtRC8zaVlNWUwxeEowcUtJMXhMbzVza1ZIZTAzazA3blE5RTcyQysrK1U9</response>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:15 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:15 | [Mutex] notify: [event, disconnected]

2019-12-03 20:25:15 | [Mutex] received everything.

2019-12-03 20:25:15 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:15 | [Mutex] waiting for: [event]

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1rU1RFcW5yMjNjTkN2ZVFkN1R1dA==</auth>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rU1RFcW5yMjNjTkN2ZVFkN1R1dHlUTzcxRTlxdGd0dUd4dW5uVnJkLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a1NURXFucjIzY05DdmVRZDdUdXR5VE83MUU5cXRndHVHeHVublZyZCxwPWE3QlZjOFhBazBwbGVsM3lRYTBtY3dMWk04NUUwVzlyUDlUb2U0ekd0QTQ9</response>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:15 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:15 | [Mutex] received everything.

2019-12-03 20:25:15 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:15 | [Mutex] waiting for: [event]

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1vR1pIS0Q0TlFOTjFLR0VhSGpWSg==</auth>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vR1pIS0Q0TlFOTjFLR0VhSGpWSk5uNUNDUXBHajFjZE5WdVZiVUlzLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b0daSEtENE5RTk4xS0dFYUhqVkpObjVDQ1FwR2oxY2ROVnVWYlVJcyxwPUprbUxvMGFELzhNeHdISkJQZjVXUmRRdkNTZHJKdzNWTENkNGdiRWx6cjQ9</response>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:15 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:15 | [Mutex] received everything.

2019-12-03 20:25:15 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:15 | [Mutex] waiting for: [event]

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj13V2pWUWY0TUcybDQ0VkVrVk9LQQ==</auth>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13V2pWUWY0TUcybDQ0VkVrVk9LQVZESkMxclZRdkpoN1BoQVVmVmg0LHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d1dqVlFmNE1HMmw0NFZFa1ZPS0FWREpDMXJWUXZKaDdQaEFVZlZoNCxwPWhkV280bWFsSlBvbFRaZTdEUlQwa3F3WDV6ZEs0QnZVN1JLY2VlZDJZSVU9</response>

2019-12-03 20:25:15 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:15 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:15 | [Mutex] received everything.

2019-12-03 20:25:15 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:15 | [Mutex] waiting for: [event]

2019-12-03 20:25:15 | user :: user_kljwc10027@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-12-03 20:25:15 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:16 | user :: user_kljwc10027@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-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1zbGhIVnZpTWhucDg4YXNIenFtZg==</auth>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zbGhIVnZpTWhucDg4YXNIenFtZllEOVJXTHYzNEl4b0diM3k2QmoyLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c2xoSFZ2aU1obnA4OGFzSHpxbWZZRDlSV0x2MzRJeG9HYjN5NkJqMixwPXFwTXNYZ1BUNDJiTHNQVUo4N25pT2ZRemthTjUvTkdwZGtBcnh4VlErSEE9</response>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:16 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:16 | [Mutex] received everything.

2019-12-03 20:25:16 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:16 | [Mutex] waiting for: [event]

2019-12-03 20:25:16 | user :: user_kljwc10027@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-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:16 | user :: user_kljwc10027@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-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1HT2RGSzRjTnJzcmNhY1ZiTG1RWA==</auth>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HT2RGSzRjTnJzcmNhY1ZiTG1RWDZST0ZLMEpYZXpzRVNSQVduRTNCLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R09kRks0Y05yc3JjYWNWYkxtUVg2Uk9GSzBKWGV6c0VTUkFXbkUzQixwPXBFakJYQURmZjdmQnkzbVBFNFduSytBNGxQbjVUak5lZnhFbjA4R0h0clE9</response>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:16 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:16 | [Mutex] received everything.

2019-12-03 20:25:16 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:16 | [Mutex] waiting for: [event]

2019-12-03 20:25:16 | user :: user_kljwc10027@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-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:16 | user :: user_kljwc10027@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-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1GTWZZMGxVdmpuRVo2WnRuYTRaeQ==</auth>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GTWZZMGxVdmpuRVo2WnRuYTRaeWZkaFB4SHF5V3h4dU04QzVmbE5DLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Rk1mWTBsVXZqbkVaNlp0bmE0WnlmZGhQeEhxeVd4eHVNOEM1ZmxOQyxwPTREOFRpQUc3aTQ0ejJKMndwWmtJMERxNjhJYnkxaXVDSHR0TTB2bE1VcW89</response>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:16 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:16 | [Mutex] received everything.

2019-12-03 20:25:16 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:16 | [Mutex] notify: [event, disconnected]

2019-12-03 20:25:16 | user :: user_kljwc10027@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-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:16 | user :: user_kljwc10027@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-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tsandjMTAwMjcscj1YaDZOandRdEtsa1RucUxuOTFDMg==</auth>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YaDZOandRdEtsa1RucUxuOTFDMlpFR2tKMDNFQkdrZ0trZEhpZlBrLHM9cnJOR0twdFFFaEJhb1E9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WGg2Tmp3UXRLbGtUbnFMbjkxQzJaRUdrSjAzRUJHa2dLa2RIaWZQayxwPXJlK1FmQ2pMbFgrTGZ5a1VvTWpKanhPQ0hIV1dPQ1NGZi9GSWo2dTdBK0k9</response>

2019-12-03 20:25:16 | user :: user_kljwc10027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: user_kljwc10027@localhost is not authorized to act as user_kljwc10027@localhost</text></failure>

2019-12-03 20:25:18 | [Mutex] waiting for: [user]

2019-12-03 20:25:18 | [Mutex] received everything.

2019-12-03 20:25:18 | [Mutex] isItemNotified: user:ok:false :: true

2019-12-03 20:25:18 |

2019-12-03 20:25:18 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-12-03 20:25:18 | ------------------------------------

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4986c978

2019-12-03 20:25:18 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@47413e38}, 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@437ea208}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@67c3403}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@79cee0bd}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:18 PST 2019}}}}

2019-12-03 20:25:18 | [Mutex] waiting for: [registration]

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@37b0b142

2019-12-03 20:25:18 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@47413e38}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@437ea208}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@67c3403}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@79cee0bd}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:18 PST 2019}}}}

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@1e83b5e

2019-12-03 20:25:18 | 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-12-03 20:25:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6653cb4c}

2019-12-03 20:25:18 | 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-12-03 20:25:18 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:18 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@68160433

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5a9e82d2

2019-12-03 20:25:18 | 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-12-03 20:25:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1aec7014}

2019-12-03 20:25:18 | 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-12-03 20:25:18 | user :: null >> <iq to="localhost" id="lRAlP1udus38lLziHwhJKZg" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-12-03 20:25:18 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b087c4b4}

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

2019-12-03 20:25:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@621dd1ae}

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3a726642

2019-12-03 20:25:18 | user :: null >> <iq to="localhost" id="rBM09kJx7oTU3hQbEm9soeF" type="set"><query xmlns="jabber:iq:register"><username>user_f1tuqf0028</username><password>user_f1tuqf0028</password><email>b3e86923-951c-45ff-882b-e329493f9b86@localhost</email></query></iq>

2019-12-03 20:25:18 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@fe52a59}

2019-12-03 20:25:18 | [Mutex] received everything.

2019-12-03 20:25:18 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-03 20:25:18 | user :: null << <iq xmlns="jabber:client" id="rBM09kJx7oTU3hQbEm9soeF" from="localhost" type="result"/>

2019-12-03 20:25:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1454ebcc}

2019-12-03 20:25:18 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6653cb4c, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1aec7014]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@47413e38}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@437ea208}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@67c3403}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@79cee0bd}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:18 PST 2019}}}}

2019-12-03 20:25:18 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6653cb4c, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1aec7014]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@47413e38}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@437ea208}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@67c3403}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@79cee0bd}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:18 PST 2019}}}}

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6d415582

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@61dd6925

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@48b4532a

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7b0ddb7b

2019-12-03 20:25:18 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1c876cdd

2019-12-03 20:25:18 | user :: user_f1tuqf0028@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-12-03 20:25:18 | user :: user_f1tuqf0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:18 | user :: user_f1tuqf0028@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-12-03 20:25:18 | user :: user_f1tuqf0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2YxdHVxZjAwMjgscj1OdWlLUTlpRFRqSUxZakpUSXhwUw==</auth>

2019-12-03 20:25:18 | user :: user_f1tuqf0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OdWlLUTlpRFRqSUxZakpUSXhwU3VvbmZ2U1htSHdhQmdsd3J3TFBhLHM9d2hPM0huL0QyT012NkE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:18 | user :: user_f1tuqf0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TnVpS1E5aURUaklMWWpKVEl4cFN1b25mdlNYbUh3YUJnbHdyd0xQYSxwPXpDOHNqcG8vMUVFVHBKKzZEcldock8rSjZacW85SnQxM2ZzL2hxaWF4aFE9</response>

2019-12-03 20:25:18 | user :: user_f1tuqf0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1BTzVKNFg0bWVlb0dpYURvNzNYYTl3ZkNmUnlkU2RQUEhrcndrM2luaHRFPQ==</success>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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 hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="tayVLFeRarzqpIYlhM87XxlAcgo="/></features>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <iq xmlns="jabber:client" id="RTCpXh0fyAjEnPHydylR0vi" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost << <iq xmlns="jabber:client" id="RTCpXh0fyAjEnPHydylR0vi" type="result" to="user_f1tuqf0028@localhost/993927746-tigase-20"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_f1tuqf0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="d34yjCHN17zlP1udus38lLz" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" id="d34yjCHN17zlP1udus38lLz" type="result" to="user_f1tuqf0028@localhost/993927746-tigase-20"/>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="rEP6lIv5dAhGBn2zqUfEM0d" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost/993927746-tigase-20 << <enabled xmlns="urn:xmpp:sm:3" max="60" id="4a22bf1e-d3de-43f3-8d3b-02a76f67f79a" resume="true" location="d4270859fb27"/>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost/993927746-tigase-20 >> <iq id="7TwviEJCISXUhXlLRVZl8v4" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" id="rEP6lIv5dAhGBn2zqUfEM0d" from="localhost" type="result" to="user_f1tuqf0028@localhost/993927746-tigase-20"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="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="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" id="7TwviEJCISXUhXlLRVZl8v4" type="result" to="user_f1tuqf0028@localhost/993927746-tigase-20"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 20:25:19 | Disconnecting

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

2019-12-03 20:25:19 | [Mutex] notify: [disconnected]

2019-12-03 20:25:19 | [Mutex] received everything.

2019-12-03 20:25:19 | [Mutex] notify: [disconnected]

2019-12-03 20:25:19 | [Mutex] waiting for: [event]

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2YxdHVxZjAwMjgscj1UNHFoMG81SFRDckFaWUVieloweg==</auth>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UNHFoMG81SFRDckFaWUVielowek1lVzNpb1FLalplejFoVDZ1cEp3LHM9d2hPM0huL0QyT012NkE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VDRxaDBvNUhUQ3JBWllFYnpaMHpNZVczaW9RS2paZXoxaFQ2dXBKdyxwPTEyRzZTNXNTLzNSeHZ5d0Q4Y29odk5ubXB0a2xqQlF2ZEwyVkZVKzdWSTA9</response>

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

2019-12-03 20:25:19 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:19 | [Mutex] received everything.

2019-12-03 20:25:19 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:19 | [Mutex] waiting for: [event]

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2YxdHVxZjAwMjgscj01TDRGZWJzNjZ5M0xsbWVTVmdqMg==</auth>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01TDRGZWJzNjZ5M0xsbWVTVmdqMkl1ekd6ZmpMT0czcWVTaWNlczEyLHM9d2hPM0huL0QyT012NkE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NUw0RmViczY2eTNMbG1lU1ZnajJJdXpHemZqTE9HM3FlU2ljZXMxMixwPUtCaFp2MVhudWxmYVlhRnhXZ0w4YlVyTlZCc05PU2JYNzhrNUdlbVg5UDQ9</response>

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

2019-12-03 20:25:19 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:19 | [Mutex] received everything.

2019-12-03 20:25:19 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:19 | [Mutex] waiting for: [event]

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2YxdHVxZjAwMjgscj1ZQlVqYklVM0N2cWp4QzNsNHFVVA==</auth>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZQlVqYklVM0N2cWp4QzNsNHFVVGk5Y2luaElLQ3FoRTRwcXlOVGNhLHM9d2hPM0huL0QyT012NkE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WUJVamJJVTNDdnFqeEMzbDRxVVRpOWNpbmhJS0NxaEU0cHF5TlRjYSxwPWRxZGxYQkNZOXkrb3BIODJTZTNxNzFSMUxDWjJkakRpV3lXMkYycXUrbk09</response>

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

2019-12-03 20:25:19 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:19 | [Mutex] notify: [event, disconnected]

2019-12-03 20:25:19 | [Mutex] received everything.

2019-12-03 20:25:19 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:19 | [Mutex] waiting for: [event]

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2YxdHVxZjAwMjgscj1TN2dZZThiRVBKclI3NVllUmRpRA==</auth>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TN2dZZThiRVBKclI3NVllUmRpRHNMS1JrTWJrdjQzQ2lqNEl1ZklWLHM9d2hPM0huL0QyT012NkE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UzdnWWU4YkVQSnJSNzVZZVJkaURzTEtSa01ia3Y0M0NpajRJdWZJVixwPWdJazIvWTl4Z2NqZEJuN2ZXQ2pxaHZWeEhjdFdmdXl3eHYrenZZbDlxWGM9</response>

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

2019-12-03 20:25:19 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:19 | [Mutex] received everything.

2019-12-03 20:25:19 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@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-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2YxdHVxZjAwMjgscj1uempoVktXenFTODB3a1pvbnNzRQ==</auth>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uempoVktXenFTODB3a1pvbnNzRUZ5VjdkZ1RkTWFHeEZCdXpobnNBLHM9d2hPM0huL0QyT012NkE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:19 | user :: user_f1tuqf0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bnpqaFZLV3pxUzgwd2tab25zc0VGeVY3ZGdUZE1hR3hGQnV6aG5zQSxwPWN6WWFHemlqK25PSXNLRVY0MEQ2SG5SaERpWVFMOFVoSTdEakttYlEvS1U9</response>

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

2019-12-03 20:25:21 | [Mutex] waiting for: [user]

2019-12-03 20:25:21 | [Mutex] received everything.

2019-12-03 20:25:21 | [Mutex] isItemNotified: user:ok:true :: true

2019-12-03 20:25:21 |

2019-12-03 20:25:21 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-12-03 20:25:21 | ------------------------------------

2019-12-03 20:25:21 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@58e25d5f

2019-12-03 20:25:21 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5625b833}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@521a362f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1718b208}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5dda1d11}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:21 PST 2019}}}}

2019-12-03 20:25:21 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2645c2b9

2019-12-03 20:25:21 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5625b833}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@521a362f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1718b208}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5dda1d11}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:21 PST 2019}}}}

2019-12-03 20:25:21 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@256d3310

2019-12-03 20:25:21 | [Mutex] waiting for: [registration]

2019-12-03 20:25:21 | 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-12-03 20:25:21 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@77374d47}

2019-12-03 20:25:21 | 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-12-03 20:25:21 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:21 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-12-03 20:25:21 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@7a08f425

2019-12-03 20:25:21 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@72d0b1d7

2019-12-03 20:25:21 | 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-12-03 20:25:21 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3e69f92e}

2019-12-03 20:25:21 | 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-12-03 20:25:21 | user :: null >> <iq to="localhost" id="DWzBu2vaO4lGP3x9Dt5xwhC" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-12-03 20:25:21 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@125a45f0}

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

2019-12-03 20:25:21 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7379d6d1}

2019-12-03 20:25:21 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@4e6dad47

2019-12-03 20:25:21 | user :: null >> <iq to="localhost" id="U2P4nO6lIv5dAhGBn2zqUfE" type="set"><query xmlns="jabber:iq:register"><username>user_bm5duo0029</username><password>user_bm5duo0029</password><email>8032594a-6817-4404-be34-c7971d6f58eb@localhost</email></query></iq>

2019-12-03 20:25:21 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5ecd5ad4}

2019-12-03 20:25:22 | user :: null << <iq xmlns="jabber:client" id="U2P4nO6lIv5dAhGBn2zqUfE" from="localhost" type="result"/>

2019-12-03 20:25:22 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@39c4e354}

2019-12-03 20:25:22 | [Mutex] received everything.

2019-12-03 20:25:22 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-03 20:25:22 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@77374d47, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3e69f92e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5625b833}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@521a362f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1718b208}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5dda1d11}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:22 PST 2019}}}}

2019-12-03 20:25:22 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@77374d47, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3e69f92e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5625b833}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@521a362f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1718b208}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5dda1d11}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:22 PST 2019}}}}

2019-12-03 20:25:22 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4815cdcb

2019-12-03 20:25:22 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@75675546

2019-12-03 20:25:22 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@56c3d938

2019-12-03 20:25:22 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@48034ef7

2019-12-03 20:25:22 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2e9ea9a9

2019-12-03 20:25:22 | user :: user_bm5duo0029@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-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:22 | user :: user_bm5duo0029@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-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2JtNWR1bzAwMjkscj1TaDdPWVhkMVFSazE3SkdBTGRtag==</auth>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TaDdPWVhkMVFSazE3SkdBTGRtakJHeE96eXpKQ2NLQnRSeXF2WTM3LHM9bUwrYld1eGVBcTdMZGc9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U2g3T1lYZDFRUmsxN0pHQUxkbWpCR3hPenl6SkNjS0J0UnlxdlkzNyxwPW9nNXhKaUdrSHlKOGdrSEJUZDdkZ2kvaW5yZklNNUdUM2M0RjdlN0dSdWc9</response>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1WVXRzMDZoSmRuajlmb1ArWmFDOGhtRkVuZEkzZ3Zmd3l2V2xNekc5aVUwPQ==</success>

2019-12-03 20:25:22 | user :: user_bm5duo0029@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 hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="tayVLFeRarzqpIYlhM87XxlAcgo="/></features>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <iq xmlns="jabber:client" id="mTmP1udus38lLziHwhJKZgA" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost << <iq xmlns="jabber:client" id="mTmP1udus38lLziHwhJKZgA" type="result" to="user_bm5duo0029@localhost/993927746-tigase-21"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_bm5duo0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="U4R8v4CnMDlJClORT4DyaLG" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" id="U4R8v4CnMDlJClORT4DyaLG" type="result" to="user_bm5duo0029@localhost/993927746-tigase-21"/>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="TRcJU3aOLybrV07mX5sp6gX" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost/993927746-tigase-21 << <enabled xmlns="urn:xmpp:sm:3" max="60" id="464b72f8-0651-4ccd-988f-c728a57972fa" resume="true" location="d4270859fb27"/>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost/993927746-tigase-21 >> <iq id="i8ZnPZbvncDk8pQLBfEpW7p" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost/993927746-tigase-21 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" id="TRcJU3aOLybrV07mX5sp6gX" from="localhost" type="result" to="user_bm5duo0029@localhost/993927746-tigase-21"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="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="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" id="i8ZnPZbvncDk8pQLBfEpW7p" type="result" to="user_bm5duo0029@localhost/993927746-tigase-21"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 20:25:22 | Disconnecting

2019-12-03 20:25:22 | [Mutex] notify: [disconnected]

2019-12-03 20:25:22 | [Mutex] received everything.

2019-12-03 20:25:22 | [Mutex] waiting for: [event]

2019-12-03 20:25:22 | user :: user_bm5duo0029@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-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:22 | user :: user_bm5duo0029@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-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfYm01ZHVvMDAyOQAgLSAtIC0gLSAt</auth>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:22 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:22 | [Mutex] notify: [event, disconnected]

2019-12-03 20:25:22 | [Mutex] received everything.

2019-12-03 20:25:22 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:22 | [Mutex] waiting for: [event]

2019-12-03 20:25:22 | user :: user_bm5duo0029@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-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:22 | user :: user_bm5duo0029@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-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2JtNWR1bzAwMjkscj00dHhFNDZFMkpPS2JRMUxIdEtHVw==</auth>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00dHhFNDZFMkpPS2JRMUxIdEtHV0w3c1g4UFN0eDVMZGkyM3Q5M1Z4LHM9bUwrYld1eGVBcTdMZGc9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NHR4RTQ2RTJKT0tiUTFMSHRLR1dMN3NYOFBTdHg1TGRpMjN0OTNWeCxwPTZnUnBIWmhxUS8xMitNSXR6SjdQTHg5N0RDcjhjS09VNzNZdUhPelRsMVU9</response>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:22 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:22 | [Mutex] notify: [event, disconnected]

2019-12-03 20:25:22 | [Mutex] received everything.

2019-12-03 20:25:22 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:22 | [Mutex] waiting for: [event]

2019-12-03 20:25:22 | user :: user_bm5duo0029@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-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:22 | user :: user_bm5duo0029@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-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfYm01ZHVvMDAyOQAgLSAtIC0gLSAt</auth>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:22 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:22 | [Mutex] received everything.

2019-12-03 20:25:22 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:22 | [Mutex] waiting for: [event]

2019-12-03 20:25:22 | user :: user_bm5duo0029@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-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:22 | user :: user_bm5duo0029@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-12-03 20:25:22 | user :: user_bm5duo0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2JtNWR1bzAwMjkscj1PVUdhUXVKQlBqdXNmSGJPeU83cw==</auth>

2019-12-03 20:25:22 | user :: user_bm5duo0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PVUdhUXVKQlBqdXNmSGJPeU83c2pKcHRUTWRoOUVBV1FYRWxodVZaLHM9cnBrTGNpM2taSE1oYXc9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:23 | user :: user_bm5duo0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T1VHYVF1SkJQanVzZkhiT3lPN3NqSnB0VE1kaDlFQVdRWEVsaHVWWixwPTlCU0lqSk1QUk5mN1BzOXpmampUK1J4TC9mVT0=</response>

2019-12-03 20:25:23 | user :: user_bm5duo0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:23 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:23 | [Mutex] received everything.

2019-12-03 20:25:23 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:23 | user :: user_bm5duo0029@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-12-03 20:25:23 | user :: user_bm5duo0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:23 | user :: user_bm5duo0029@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-12-03 20:25:23 | user :: user_bm5duo0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2JtNWR1bzAwMjkscj1NZDdYbDI0Q3NQWTBvQmJLZVVFeg==</auth>

2019-12-03 20:25:23 | user :: user_bm5duo0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NZDdYbDI0Q3NQWTBvQmJLZVVFekJQUnFGa1k2UVRmazdubGVLWUVKLHM9bUwrYld1eGVBcTdMZGc9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:23 | user :: user_bm5duo0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TWQ3WGwyNENzUFkwb0JiS2VVRXpCUFJxRmtZNlFUZms3bmxlS1lFSixwPWhFUVR5WDdCNUc0V0JEMjlqcDRNcjJISnAyQk5uK3I2WkpscU9JbzBlZnM9</response>

2019-12-03 20:25:23 | user :: user_bm5duo0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:25 | [Mutex] waiting for: [user]

2019-12-03 20:25:25 | [Mutex] received everything.

2019-12-03 20:25:25 | [Mutex] isItemNotified: user:ok:true :: true

2019-12-03 20:25:25 |

2019-12-03 20:25:25 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-12-03 20:25:25 | ------------------------------------

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4cb6a6e0

2019-12-03 20:25:25 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@42715106}, 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@464ecd90}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@34c5b3d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a346c12}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:25 PST 2019}}}}

2019-12-03 20:25:25 | [Mutex] waiting for: [registration]

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3285fb33

2019-12-03 20:25:25 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@42715106}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@464ecd90}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@34c5b3d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a346c12}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:25 PST 2019}}}}

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@21792be

2019-12-03 20:25:25 | 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-12-03 20:25:25 | 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-12-03 20:25:25 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6363a472}

2019-12-03 20:25:25 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:25 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3aee00f0

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@27af28fd

2019-12-03 20:25:25 | 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-12-03 20:25:25 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1913dcd4}

2019-12-03 20:25:25 | 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-12-03 20:25:25 | user :: null >> <iq to="localhost" id="bd8ogY9i3vrXfHxrkTQatY1" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-12-03 20:25:25 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3b7da355}

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

2019-12-03 20:25:25 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@672dbbb0}

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@2d0ece25

2019-12-03 20:25:25 | user :: null >> <iq to="localhost" id="Oc3v5vdzvs9mcx6hDjMFs9t" type="set"><query xmlns="jabber:iq:register"><username>user_ecr9oj0030</username><password>user_ecr9oj0030</password><email>39bace65-d2b9-4600-87d9-9aa65c380bce@localhost</email></query></iq>

2019-12-03 20:25:25 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b7182d4c}

2019-12-03 20:25:25 | user :: null << <iq xmlns="jabber:client" id="Oc3v5vdzvs9mcx6hDjMFs9t" from="localhost" type="result"/>

2019-12-03 20:25:25 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7338e3b9}

2019-12-03 20:25:25 | [Mutex] received everything.

2019-12-03 20:25:25 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-03 20:25:25 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6363a472, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1913dcd4]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@42715106}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@464ecd90}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@34c5b3d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a346c12}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:25 PST 2019}}}}

2019-12-03 20:25:25 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@5360a327}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6363a472, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1913dcd4]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@42715106}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62c9e919}, 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@464ecd90}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@34c5b3d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a346c12}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 20:25:25 PST 2019}}}}

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@74ca7476

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7eb0a164

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@25943771

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@11853d51

2019-12-03 20:25:25 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@364b92d3

2019-12-03 20:25:25 | user :: user_ecr9oj0030@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-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@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-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2VjcjlvajAwMzAscj1hcnF5NHFyOHNaaWFxRVBDQm8xMA==</auth>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hcnF5NHFyOHNaaWFxRVBDQm8xMHg2M0lydVVzcWJFVGdocGpVbUlULHM9MGRiNkRGUGRpb2FqTEE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YXJxeTRxcjhzWmlhcUVQQ0JvMTB4NjNJcnVVc3FiRVRnaHBqVW1JVCxwPXdGMkJCZDBia3lDNDFTQmQ0Sld2dWpZT2lFeW5QLzlnV25sb0o1Zm4wT0E9</response>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj02c0lReW5hR2w3WnBXNDF1Nml6aCt3cWo0eSszMnplS0c2RDRxeFI4dE1JPQ==</success>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@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 hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="tayVLFeRarzqpIYlhM87XxlAcgo="/></features>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <iq xmlns="jabber:client" id="cYl8IDgZnbrdDpbORM2dsZ3" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost << <iq xmlns="jabber:client" id="cYl8IDgZnbrdDpbORM2dsZ3" type="result" to="user_ecr9oj0030@localhost/993927746-tigase-22"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_ecr9oj0030@localhost/993927746-tigase-22</jid></bind></iq>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="ocZo16Gv29nNKBkTXcT4cPO" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" id="ocZo16Gv29nNKBkTXcT4cPO" type="result" to="user_ecr9oj0030@localhost/993927746-tigase-22"/>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="MQTdP5fPRR5Ct0u7gBhBmPM" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost/993927746-tigase-22 << <enabled xmlns="urn:xmpp:sm:3" max="60" id="294bc52e-0d3c-4af0-a5e8-116272b5aac7" resume="true" location="d4270859fb27"/>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost/993927746-tigase-22 >> <iq id="4ZiNLO7w6Dqk6pO5zzdLJBz" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost/993927746-tigase-22 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" id="MQTdP5fPRR5Ct0u7gBhBmPM" from="localhost" type="result" to="user_ecr9oj0030@localhost/993927746-tigase-22"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="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="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" id="4ZiNLO7w6Dqk6pO5zzdLJBz" type="result" to="user_ecr9oj0030@localhost/993927746-tigase-22"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 20:25:25 | Disconnecting

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost/993927746-tigase-22 << <presence xmlns="jabber:client" from="user_ecr9oj0030@localhost/993927746-tigase-22" to="user_ecr9oj0030@localhost"><c hash="sha-1" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2019-12-03 20:25:25 | [Mutex] notify: [disconnected]

2019-12-03 20:25:25 | [Mutex] received everything.

2019-12-03 20:25:25 | [Mutex] waiting for: [event]

2019-12-03 20:25:25 | user :: user_ecr9oj0030@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-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@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-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2VjcjlvajAwMzAscj00bDEwTEVSU2pkUTdJRjdUMTh2bQ==</auth>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00bDEwTEVSU2pkUTdJRjdUMTh2bXJ0TTlPdm9wVVRGTHJabUlWVmxqLHM9MGRiNkRGUGRpb2FqTEE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NGwxMExFUlNqZFE3SUY3VDE4dm1ydE05T3ZvcFVURkxyWm1JVlZsaixwPUlLTXFXN2E5MjN3MWFyalg5S0NualhNNmtTK3hEdDVUQnBNVERkZHpmQjQ9</response>

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

2019-12-03 20:25:25 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:25 | [Mutex] received everything.

2019-12-03 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:25 | [Mutex] waiting for: [event]

2019-12-03 20:25:25 | user :: user_ecr9oj0030@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-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@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-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2VjcjlvajAwMzAscj1jMkZCWmhBTzBwNlhYTTc4cnROYw==</auth>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jMkZCWmhBTzBwNlhYTTc4cnROYzVGdjBlejFzU3JGUHZrMmRhMWFQLHM9MGRiNkRGUGRpb2FqTEE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YzJGQlpoQU8wcDZYWE03OHJ0TmM1RnYwZXoxc1NyRlB2azJkYTFhUCxwPTVzREtxaXJRMjFHNjYvN3FueVVhbHIvWWJIdnFPa3pFWStaR3Y0MlAzdDQ9</response>

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

2019-12-03 20:25:25 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:25 | [Mutex] received everything.

2019-12-03 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:25 | [Mutex] waiting for: [event]

2019-12-03 20:25:25 | user :: user_ecr9oj0030@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-12-03 20:25:25 | user :: user_ecr9oj0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@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-12-03 20:25:26 | user :: user_ecr9oj0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2VjcjlvajAwMzAscj1oN0ZEWG1UbjVGd2pmM3V1bGIzag==</auth>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oN0ZEWG1UbjVGd2pmM3V1bGIzam96cGExNjZFRUlPbGduWk1YUTRYLHM9MGRiNkRGUGRpb2FqTEE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aDdGRFhtVG41RndqZjN1dWxiM2pvenBhMTY2RUVJT2xnblpNWFE0WCxwPWUzRTVQSVBka1VjNlZoZHJkTmszRllTZ3dmdzZyRnNseUwzUVpUV2JWb289</response>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-03 20:25:26 | [Mutex] notify: [event, authFailed]

2019-12-03 20:25:26 | [Mutex] received everything.

2019-12-03 20:25:26 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 20:25:26 | user :: user_ecr9oj0030@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-12-03 20:25:26 | user :: user_ecr9oj0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@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-12-03 20:25:26 | user :: user_ecr9oj0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2VjcjlvajAwMzAscj1lTVJrOFFRbTlwRXZtYU1SVFJZSw==</auth>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lTVJrOFFRbTlwRXZtYU1SVFJZS1E1M0NSRkFtVWxSWWVWSzBXeXhXLHM9MGRiNkRGUGRpb2FqTEE9PSxpPTQwOTY=</challenge>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZU1SazhRUW05cEV2bWFNUlRSWUtRNTNDUkZBbVVsUlllVkswV3l4VyxwPTF0bDN3cTJNbU5acTJvZ21Yb1VGbE9sZ01oTExsVFRQT1RRQTg4dHBKeFU9</response>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0rNDBUL0V4OUxxRlN3aXovQnBtVDZiaEwzMmhQZENhYWIzdEFpb0F6NzRRPQ==</success>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@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 hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="tayVLFeRarzqpIYlhM87XxlAcgo="/></features>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost >> <iq xmlns="jabber:client" id="HjeAEKHofTdvlTVdSZ2yfw7" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost << <iq xmlns="jabber:client" id="HjeAEKHofTdvlTVdSZ2yfw7" type="result" to="user_ecr9oj0030@localhost/993927746-tigase-23"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_ecr9oj0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="pliNEMHqVVTWZ6r3ohQKV0u" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" id="pliNEMHqVVTWZ6r3ohQKV0u" type="result" to="user_ecr9oj0030@localhost/993927746-tigase-23"/>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="ijaJxp1bJU3aOLybrV07mX5" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost/993927746-tigase-23 << <enabled xmlns="urn:xmpp:sm:3" max="60" id="b6a93512-8cc4-4b5b-a7ab-7a35b50f1693" resume="true" location="d4270859fb27"/>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost/993927746-tigase-23 >> <iq id="y5sZ6r3ohQKV0uq36FJTR3j" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost/993927746-tigase-23 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" id="ijaJxp1bJU3aOLybrV07mX5" from="localhost" type="result" to="user_ecr9oj0030@localhost/993927746-tigase-23"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="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="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" id="y5sZ6r3ohQKV0uq36FJTR3j" type="result" to="user_ecr9oj0030@localhost/993927746-tigase-23"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 20:25:26 | Disconnecting

2019-12-03 20:25:26 | user :: user_ecr9oj0030@localhost/993927746-tigase-23 << <presence xmlns="jabber:client" from="user_ecr9oj0030@localhost/993927746-tigase-23" to="user_ecr9oj0030@localhost"><c hash="sha-1" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2019-12-03 20:25:26 | [Mutex] notify: [disconnected]

2019-12-03 20:25:26 | [Mutex] received everything.

2019-12-03 20:25:28 | [Mutex] waiting for: [user]

2019-12-03 20:25:28 | [Mutex] received everything.

2019-12-03 20:25:28 | [Mutex] isItemNotified: user:ok:true :: true