Brute Force Prevention

2019-11-27 19:31:19 |

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

2019-11-27 19:31:19 | ------------------------------------

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4e3e865c

2019-11-27 19:31:19 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@40f961eb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@44c6ed2c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1c46bd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3bf201d2}, 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=Wed Nov 27 19:31:19 PST 2019}}}}

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@308fc97e

2019-11-27 19:31:19 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@40f961eb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@44c6ed2c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1c46bd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3bf201d2}, 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=Wed Nov 27 19:31:19 PST 2019}}}}

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@4353fdce

2019-11-27 19:31:19 | [Mutex] waiting for: [registration]

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

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

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

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4abce5e1

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@4b611f1

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

2019-11-27 19:31:19 | 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-11-27 19:31:19 | user :: null >> <iq to="localhost" id="for3v5Ct3laMJvqQ5CueABF" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 19:31:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@31a57f8c}

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

2019-11-27 19:31:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@65a509dd}

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@489b7b65

2019-11-27 19:31:19 | user :: null >> <iq to="localhost" id="kEbr7ISVTcobOS08HR5kMO5" type="set"><query xmlns="jabber:iq:register"><username>user_eeyora0027</username><password>user_eeyora0027</password><email>0a36e541-1b76-48df-b5a2-b98d56464ce6@localhost</email></query></iq>

2019-11-27 19:31:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b70a02af}

2019-11-27 19:31:19 | user :: null << <iq id="kEbr7ISVTcobOS08HR5kMO5" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-27 19:31:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7c96c21e}

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

2019-11-27 19:31:19 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 19:31:19 | 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;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@61eb949f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@58573124]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@40f961eb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@44c6ed2c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1c46bd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3bf201d2}, 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=Wed Nov 27 19:31:19 PST 2019}}}}

2019-11-27 19:31:19 | 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;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@40f961eb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, 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@44c6ed2c}, urn:xmpp:sm:3#SM_ACK_ENABLED=Entry{scope=stream, value=false}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1c46bd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3bf201d2}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:31:19 PST 2019}}}}

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1d2912b9

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@508f0b20

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@43dc0207

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@910ae50

2019-11-27 19:31:19 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@5c79d911

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

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

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hNzd6M0l2czUzU24yOWVwTlVyQTZJN1pTc2hsSlpIMGtDSmRRbEtlLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YTc3ejNJdnM1M1NuMjllcE5VckE2STdaU3NobEpaSDBrQ0pkUWxLZSxwPUtKOGNIVHJ4dEhlbVZnTG5mMEswRENHUmdpa2tIUk5QbzM0bm1VT2JWTGc9</response>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj15dFpMWERPdC90dHh1RDFKVisvbE5lS3BLQmFRVVBKSGNSOGFZUGhUU0NRPQ==</success>

2019-11-27 19:31:19 | user :: user_eeyora0027@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="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost >> <iq xmlns="jabber:client" id="3TS5kMO5eIsX0akR7j4nRXo" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost << <iq id="3TS5kMO5eIsX0akR7j4nRXo" to="user_eeyora0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_eeyora0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="NQHrkTT1wu9l6cN2kUWj5xe" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost/993927746-tigase-19 << <iq id="NQHrkTT1wu9l6cN2kUWj5xe" to="user_eeyora0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result"/>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="aIhy9oWSXjHQVX9M0bpesj4" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost/993927746-tigase-19 << <enabled id="12a3224c-d589-470a-b95b-1949648ef778" max="60" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost/993927746-tigase-19 >> <iq id="4QDoU4BgMAdwcoZnP6rZdUg" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost/993927746-tigase-19 << <iq id="aIhy9oWSXjHQVX9M0bpesj4" to="user_eeyora0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server" 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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost/993927746-tigase-19 << <iq id="4QDoU4BgMAdwcoZnP6rZdUg" to="user_eeyora0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:31:19 | Disconnecting

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

2019-11-27 19:31:19 | [Mutex] notify: [disconnected]

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

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

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

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

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qbzNPUlhIenZ1U2t4SDNJNnVSSGl1dEdnb3Y1N2tJdHFaMWpGR21VLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:19 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9am8zT1JYSHp2dVNreEgzSTZ1UkhpdXRHZ292NTdrSXRxWjFqRkdtVSxwPVNpTGZFRlBIbW16cVl6a2l5RXQ2Sy81b3NJdzMzZUlwRTV3N2JqYTFWNmc9</response>

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

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

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

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

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

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

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

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01ZXN1cWVoZTVabmVVN3doTDYzRW82RmVMTlVVazQzanM1YmZtRzJ4LHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NWVzdXFlaGU1Wm5lVTd3aEw2M0VvNkZlTE5VVWs0M2pzNWJmbUcyeCxwPWZabVpNVWkvODNjNXFVUC9NZE9jZ0x1c1FIZDZlYXlUelM4cHBwbzErVkk9</response>

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

2019-11-27 19:31:20 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:20 | [Mutex] notify: [event, disconnected]

2019-11-27 19:31:20 | [Mutex] received everything.

2019-11-27 19:31:20 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:20 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HRzM1Q1hxOFl1SDQwRFg5MHNLR3E1Q0VxVEpJWUdkN2oweE83VWRLLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R0czNUNYcThZdUg0MERYOTBzS0dxNUNFcVRKSVlHZDdqMHhPN1VkSyxwPWtoNlZOa2kxdk9tbVhrLzZTaGtaamtJdUJFa3hCSmhJK2RsQUdiTTlibTg9</response>

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

2019-11-27 19:31:20 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:20 | [Mutex] received everything.

2019-11-27 19:31:20 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:20 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15ZFFWUHYxZWpjM25PZldpMzh4d0JXS0w4Y09YdGNLQzhuMVJRdVVuLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eWRRVlB2MWVqYzNuT2ZXaTM4eHdCV0tMOGNPWHRjS0M4bjFSUXVVbixwPVRDdURkdFlTVFI1WUI3bzVVTFlJWWk4WjdkMEk3cXh1RjNzOXFCZmFiamM9</response>

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

2019-11-27 19:31:20 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:20 | [Mutex] received everything.

2019-11-27 19:31:20 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:20 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PM2hmMkJydlZiN3g5c3VZMlA4ckRGNXQwWGdGV1c3bUhOQnJLb0N1LHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TzNoZjJCcnZWYjd4OXN1WTJQOHJERjV0MFhnRldXN21ITkJyS29DdSxwPTI3eU50MlpDcEVuU0s0MWJ4cjZxOTJYc3pteFhHckErb1RxS0xwcEJ4VW89</response>

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

2019-11-27 19:31:20 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:20 | [Mutex] received everything.

2019-11-27 19:31:20 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:20 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03WklDS0I2U2lHOUh1SHJEWWIwV1Z6bXo2N0dJU01kUFRoYjA4bmFJLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N1pJQ0tCNlNpRzlIdUhyRFliMFdWem16NjdHSVNNZFBUaGIwOG5hSSxwPUdTejJCSDYzVjBHdHdLK0w3OUc3MGx2eWdQb0lQMjNpRlFub0pXS1NUSkE9</response>

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

2019-11-27 19:31:20 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:20 | [Mutex] received everything.

2019-11-27 19:31:20 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:20 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10VTlicXMxM0F3TUlDUUN3a0FEQVFhSU1leUF3TEFFaWt6SWUydnJRLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFU5YnFzMTNBd01JQ1FDd2tBREFRYUlNZXlBd0xBRWlrekllMnZyUSxwPWNMdjJ4ODc4Z2JET3E5bGIwVXZmZFpVRmppTXNlaFVnOXJvZDBsVGhlUUE9</response>

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

2019-11-27 19:31:20 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:20 | [Mutex] received everything.

2019-11-27 19:31:20 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:20 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wS3ZXY0lWVkppYWZUYjVyYVYxVlZNU0llRDcya01BUjdOY005MmNtLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:20 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MEt2V2NJVlZKaWFmVGI1cmFWMVZWTVNJZUQ3MmtNQVI3TmNNOTJjbSxwPTNWVTR0cWEwVWRGRWZ1VkFXcWpZd2lhTmVxSllQcE1qdE4rbm1CdVNqdXM9</response>

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

2019-11-27 19:31:20 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:20 | [Mutex] received everything.

2019-11-27 19:31:20 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:20 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uWTVMbjFNcHNiRTR6dXNxSWZBbGQzOFhKRWJheW1Mall1WllVQVFWLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9blk1TG4xTXBzYkU0enVzcUlmQWxkMzhYSkViYXltTGpZdVpZVUFRVixwPXlNeWZpR281bnBLVTAybEZKeENkVU1zU2JCNURON2hLaVNCc0xUM3hVNEU9</response>

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

2019-11-27 19:31:21 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:21 | [Mutex] notify: [event, disconnected]

2019-11-27 19:31:21 | [Mutex] received everything.

2019-11-27 19:31:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:21 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mdndOQ1dhM0xISUlzYUQzNmRLYVN3elAxaVcyRlNkeHdXN05HZ3hULHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZnZ3TkNXYTNMSElJc2FEMzZkS2FTd3pQMWlXMkZTZHh3VzdOR2d4VCxwPXBTWUs3MEp1dFlBVU1LdEltUHloVDlsWWlzMVRGdENqNTdSL0FiRnhCNjg9</response>

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

2019-11-27 19:31:21 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:21 | [Mutex] received everything.

2019-11-27 19:31:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:21 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HN1UzUjd1YWRJQURicW5yWThsMXhJb0wxWEowTDBUQVpKaHlXSnhKLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RzdVM1I3dWFkSUFEYnFuclk4bDF4SW9MMVhKMEwwVEFaSmh5V0p4SixwPS9Ud1BvSDV4dCt5cGdMblhadDNZbWRYQXpUcHg1SFI0bTVmWG03M2VpSEU9</response>

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

2019-11-27 19:31:21 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:21 | [Mutex] received everything.

2019-11-27 19:31:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:21 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TbzFHOUJIbVBzb0Nxa085OTVpdHlxVjRLa0tJelFKandmY2VJa0VpLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U28xRzlCSG1Qc29DcWtPOTk1aXR5cVY0S2tLSXpRSmp3ZmNlSWtFaSxwPUlEc2xFYUEydnNNUitPcVBkZFBlL2ZuNDRGeWVNQzc4aDVFbGlEeFozZU09</response>

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

2019-11-27 19:31:21 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:21 | [Mutex] received everything.

2019-11-27 19:31:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:21 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wbzc3U1NqRUx1dGtxVEtocW1SRUxTbnlIbDlIeXJXcEF4TTR0dm9sLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cG83N1NTakVMdXRrcVRLaHFtUkVMU255SGw5SHlyV3BBeE00dHZvbCxwPUhQeEpLblc2d0tubW1INHNzQTJhL3NBOVVjekZTbWgyY3llL21lVlRtU2M9</response>

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

2019-11-27 19:31:21 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:21 | [Mutex] received everything.

2019-11-27 19:31:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:21 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16QndMYzZZYUNnbklQbXlJODJFTGtvZ2NCQWcyM1FaVzMxZnNpb1diLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ekJ3TGM2WWFDZ25JUG15STgyRUxrb2djQkFnMjNRWlczMWZzaW9XYixwPXNZb3IrK09XcnpCMFpZbEZJT1FzLzlqV3VOaDh0ZHRPQ245UkJmQWg4N2s9</response>

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

2019-11-27 19:31:21 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:21 | [Mutex] received everything.

2019-11-27 19:31:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:21 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vNVhuaTJtR0Y0MnN0VVprellMdG1PSktPdEJWZTEzZmFIcm83VUliLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bzVYbmkybUdGNDJzdFVaa3pZTHRtT0pLT3RCVmUxM2ZhSHJvN1VJYixwPWRMS1VOU1ZUTU9HU01jRCtFdXRqbDJBVHJMSjlaT2gwc3Vqd1EveFdGVWM9</response>

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

2019-11-27 19:31:21 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:21 | [Mutex] received everything.

2019-11-27 19:31:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:21 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LMjFDR2FRRkd0R3B3ZXY4TFp4Q3dqaWRMN0FXYXFwenFFelFlM2ZrLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:21 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SzIxQ0dhUUZHdEdwd2V2OExaeEN3amlkTDdBV2FxcHpxRXpRZTNmayxwPWJkMUk1RnQvQ2x5WWEyOW8rWGxhWit3L3lZcmkrcDBmc1ErT1VtZ1laQjg9</response>

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

2019-11-27 19:31:21 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:21 | [Mutex] notify: [event, disconnected]

2019-11-27 19:31:21 | [Mutex] received everything.

2019-11-27 19:31:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:21 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SYUJpalZIdERwcHFSaHlibTJZVmFOSTJDb1NTdjNWTm1Tc1FpcGtILHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UmFCaWpWSHREcHBxUmh5Ym0yWVZhTkkyQ29TU3YzVk5tU3NRaXBrSCxwPUdORUtubXFFUE9IbjlCOUIxUXBERG14ajNLNXN2WjdPUHZYMWJDV3VnOW89</response>

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

2019-11-27 19:31:22 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:22 | [Mutex] received everything.

2019-11-27 19:31:22 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:22 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rQlk2cDNHbmVLTnk5UHoyZUYwQ25XcUR6MEphZW00b0RWOEVoQkhMLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a0JZNnAzR25lS055OVB6MmVGMENuV3FEejBKYWVtNG9EVjhFaEJITCxwPU5PWkZNeS9yRndNUU5lSmFjSk9BendGbWJ3WXFDM2VqUUpJUzZyNi9UbUk9</response>

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

2019-11-27 19:31:22 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:22 | [Mutex] received everything.

2019-11-27 19:31:22 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:22 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uSGJuRnlZS3ZWZ1o2Z3BDa1NtMUY4aldMejBCSHFYT3kwSVd0ZlVTLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bkhibkZ5WUt2VmdaNmdwQ2tTbTFGOGpXTHowQkhxWE95MElXdGZVUyxwPTNrRmlYMDF2M3FHTlUvcTBBU3U1d1daS3QwQi9NV2FqT0lwd0k5TzQxN289</response>

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

2019-11-27 19:31:22 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:22 | [Mutex] notify: [event, disconnected]

2019-11-27 19:31:22 | [Mutex] received everything.

2019-11-27 19:31:22 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:22 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QcFZZTWJ0WVIyQ2tiUzZjOVZNQm5kdmpFQ3RxSVVEYkpUZTVZQnlrLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UHBWWU1idFlSMkNrYlM2YzlWTUJuZHZqRUN0cUlVRGJKVGU1WUJ5ayxwPWUyUFlNQzIwSXVlSXFUR1JQWHFXZ0ZnbTJyZ3gxZDFYNTNpYkxuM0t2Smc9</response>

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

2019-11-27 19:31:22 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:22 | [Mutex] received everything.

2019-11-27 19:31:22 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:22 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VVlhzU1JjZlZ0M1JXcFQzd0FwejBPZnFsNjNKcEZhVEtIamwxeEg1LHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VVZYc1NSY2ZWdDNSV3BUM3dBcHowT2ZxbDYzSnBGYVRLSGpsMXhINSxwPTV5a2IzVStFeXIyR2lIc3ZXZWxCdnQwZUQ2OTJSRWRNV0RUMHA2aGlHVU09</response>

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

2019-11-27 19:31:22 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:22 | [Mutex] received everything.

2019-11-27 19:31:22 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GN0hKb1R1bWRQZ2ZUTTVyTHliM20zTVU4dGNrZ1oyZW9obldycFYzLHM9WjJnMlkydFhCVk1ENlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:22 | user :: user_eeyora0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RjdISm9UdW1kUGdmVE01ckx5YjNtM01VOHRja2daMmVvaG5XcnBWMyxwPTZRZ3ZOVFloZnJiY0FKMUlXUFkzYS9OSjVQcWxXOFUxN0RTQnlCU2VubmM9</response>

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

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

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

2019-11-27 19:31:24 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-27 19:31:24 |

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

2019-11-27 19:31:24 | ------------------------------------

2019-11-27 19:31:24 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@527e3455

2019-11-27 19:31:24 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@71909db4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5cb9d06a}, 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@58865f25}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1d84da51}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3e7b9928}, 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=Wed Nov 27 19:31:24 PST 2019}}}}

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

2019-11-27 19:31:24 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2cd3240d

2019-11-27 19:31:24 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5cb9d06a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@58865f25}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1d84da51}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3e7b9928}, 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=Wed Nov 27 19:31:24 PST 2019}}}}

2019-11-27 19:31:24 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@46c639c5

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

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

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

2019-11-27 19:31:24 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1ffb515a

2019-11-27 19:31:24 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2a3dede4

2019-11-27 19:31: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-11-27 19:31:25 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5dc2f177}

2019-11-27 19:31: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-11-27 19:31:25 | user :: null >> <iq to="localhost" id="zZYhIymbq6ev6mIDFpgLDvu" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 19:31:25 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@48a252b0}

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

2019-11-27 19:31:25 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@79e5bc04}

2019-11-27 19:31:25 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3c5143e3

2019-11-27 19:31:25 | user :: null >> <iq to="localhost" id="HzGnQQGzx9KJzneUZ1sUdS0" type="set"><query xmlns="jabber:iq:register"><username>user_jx59vh0028</username><password>user_jx59vh0028</password><email>d2df0e57-a23f-47ae-bfbb-113836255902@localhost</email></query></iq>

2019-11-27 19:31:25 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ab1308bf}

2019-11-27 19:31:25 | user :: null << <iq id="HzGnQQGzx9KJzneUZ1sUdS0" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-27 19:31:25 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@79c6cb40}

2019-11-27 19:31:25 | [Mutex] received everything.

2019-11-27 19:31:25 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 19:31: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;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7dab251e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5dc2f177]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5cb9d06a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@58865f25}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1d84da51}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3e7b9928}, 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=Wed Nov 27 19:31:25 PST 2019}}}}

2019-11-27 19:31: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;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7dab251e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5dc2f177]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5cb9d06a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@58865f25}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1d84da51}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3e7b9928}, 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=Wed Nov 27 19:31:25 PST 2019}}}}

2019-11-27 19:31:25 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3345c446

2019-11-27 19:31:25 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@67144bb6

2019-11-27 19:31:25 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@516c42ec

2019-11-27 19:31:25 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1ebf0f4a

2019-11-27 19:31:25 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3458f2f

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

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

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OZWJqS0p1a2RGSGRTeWp2cGkxWnR5Nkg5OG1xdGMxS1EyRnNXdUVnLHM9Q2hNV0lNUzNSTzBESHc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TmViaktKdWtkRkhkU3lqdnBpMVp0eTZIOThtcXRjMUtRMkZzV3VFZyxwPTlPZnBLaHF0TDVpSGt5YnVDRHc5cmU5Q0szUHR5TWVzWks5S0hyTWhyVTg9</response>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1RN1p0aVdrcnprK0VTb2xhYVV4QTlJWC93aFNzMnFTRkE0SVJoeGV1N2hVPQ==</success>

2019-11-27 19:31:25 | user :: user_jx59vh0028@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="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost >> <iq xmlns="jabber:client" id="SNk6EtZoMXmYcwtpbwaADkU" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost << <iq id="SNk6EtZoMXmYcwtpbwaADkU" to="user_jx59vh0028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_jx59vh0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="7Podueu18qQTbrkTT1wu9l6" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost/993927746-tigase-20 << <iq id="7Podueu18qQTbrkTT1wu9l6" to="user_jx59vh0028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result"/>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="xI1rl3gEyzcEkHu8gJRN2jJ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost/993927746-tigase-20 << <enabled id="82ca1581-9a79-4dec-a406-1b43429eec45" max="60" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost/993927746-tigase-20 >> <iq id="mQncQRLWS9KKKCFNX4gM16s" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost/993927746-tigase-20 << <iq id="xI1rl3gEyzcEkHu8gJRN2jJ" to="user_jx59vh0028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server" 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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost/993927746-tigase-20 << <iq id="mQncQRLWS9KKKCFNX4gM16s" to="user_jx59vh0028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:31:25 | Disconnecting

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

2019-11-27 19:31:25 | [Mutex] notify: [disconnected]

2019-11-27 19:31:25 | [Mutex] received everything.

2019-11-27 19:31:25 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KSVJMV2tKUE44T2pkQ3haUUhMdDhzZFp0QmtJcGR4dEU4Z3QxaVZOLHM9Q2hNV0lNUzNSTzBESHc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SklSTFdrSlBOOE9qZEN4WlFITHQ4c2RadEJrSXBkeHRFOGd0MWlWTixwPWg5bVZsUnFHVElwUGZPWnR6TFI1V0JFQzNYT2Q3c2tUK1diYnlVOWUwTzQ9</response>

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

2019-11-27 19:31:25 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:25 | [Mutex] received everything.

2019-11-27 19:31:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:25 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OdmV0UXh0M1hQR04xT0t6Njdod0dqdkhzU0ZQSW5NZmp5ampabHY5LHM9Q2hNV0lNUzNSTzBESHc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TnZldFF4dDNYUEdOMU9LejY3aHdHanZIc1NGUEluTWZqeWpqWmx2OSxwPTdJMVVPSUJTRkxrTDloSjFKNWtWMGVyU1NFcWU1TzlyNlJ5b3p4TWRZN1U9</response>

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

2019-11-27 19:31:25 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:25 | [Mutex] received everything.

2019-11-27 19:31:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:25 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qNm5UVzgwNUp0RTFuOXlnZHIyWFgwcUtVWmoxRDc5bUQzN1BNZ3NaLHM9Q2hNV0lNUzNSTzBESHc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ajZuVFc4MDVKdEUxbjl5Z2RyMlhYMHFLVVpqMUQ3OW1EMzdQTWdzWixwPVY4UFY2ODBtbTV5UkZJMjFqT2dsS1BWZk4xTGRFTjU5ZXZrUE5WaHZzZWM9</response>

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

2019-11-27 19:31:25 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:25 | [Mutex] received everything.

2019-11-27 19:31:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:25 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jT0d2VkhvSkZyMUJBdXZubVdTTjFwSTFGVU9IR2JwQzZpREQ3S0JuLHM9Q2hNV0lNUzNSTzBESHc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:25 | user :: user_jx59vh0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y09HdlZIb0pGcjFCQXV2bm1XU04xcEkxRlVPSEdicEM2aUREN0tCbixwPW9pTFQwbDROUnJudHZWYWdrMm5pcWpjbTN5QVdVZUQ0SmhNcEs3M3dPSFk9</response>

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

2019-11-27 19:31:25 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:25 | [Mutex] received everything.

2019-11-27 19:31:25 | [Mutex] isItemNotified: authFailed :: true

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

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

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

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

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

2019-11-27 19:31:28 | [Mutex] waiting for: [user]

2019-11-27 19:31:28 | [Mutex] received everything.

2019-11-27 19:31:28 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-27 19:31:28 |

2019-11-27 19:31:28 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-27 19:31:28 | ------------------------------------

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@42c09178

2019-11-27 19:31:28 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@71909db4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4c076750}, 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@4838fa08}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@d3a6d6b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4b3766e5}, 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=Wed Nov 27 19:31:28 PST 2019}}}}

2019-11-27 19:31:28 | [Mutex] waiting for: [registration]

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3cfda534

2019-11-27 19:31:28 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4c076750}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@4838fa08}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@d3a6d6b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4b3766e5}, 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=Wed Nov 27 19:31:28 PST 2019}}}}

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@331af019

2019-11-27 19:31:28 | 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-11-27 19:31:28 | 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-11-27 19:31:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6d159224}

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

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

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1d65d12d

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4c6003b0

2019-11-27 19:31:28 | 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-11-27 19:31:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@281eb81d}

2019-11-27 19:31:28 | 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-11-27 19:31:28 | user :: null >> <iq to="localhost" id="BObsaNEy8jIAaxt1udxj6Et" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 19:31:28 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@cbbc41a1}

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

2019-11-27 19:31:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@695b8b88}

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5a84c337

2019-11-27 19:31:28 | user :: null >> <iq to="localhost" id="gSl3bORPTgY7hYWh0gMGN3t" type="set"><query xmlns="jabber:iq:register"><username>user_9i2mck0029</username><password>user_9i2mck0029</password><email>231d4bf4-f37e-4b98-9c2c-39b4e07eea36@localhost</email></query></iq>

2019-11-27 19:31:28 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8516ebca}

2019-11-27 19:31:28 | user :: null << <iq id="gSl3bORPTgY7hYWh0gMGN3t" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-27 19:31:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@16352654}

2019-11-27 19:31:28 | [Mutex] received everything.

2019-11-27 19:31:28 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 19:31:28 | 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;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6d159224, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@281eb81d]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4c076750}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@4838fa08}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@d3a6d6b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4b3766e5}, 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=Wed Nov 27 19:31:28 PST 2019}}}}

2019-11-27 19:31:28 | 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;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6d159224, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@281eb81d]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4c076750}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@4838fa08}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@d3a6d6b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4b3766e5}, 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=Wed Nov 27 19:31:28 PST 2019}}}}

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4b36aadf

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7e047ffa

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2658676

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

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3ddd07e8

2019-11-27 19:31:28 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@43c322de

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

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IZ0FhaWZrVVdkSkZwckxpRzdQcUxaSWRqVDVhN1dyNzRVN0tPdXJILHM9SHZhMmhta0pMQ1ZIS1E9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SGdBYWlma1VXZEpGcHJMaUc3UHFMWklkalQ1YTdXcjc0VTdLT3VySCxwPUNwK244S3VmUk5iOFhVRGhhQzJ4NFNDS3o2OTVFdCtaaFZoY2tWMm5KY0k9</response>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ibTFDdzM5dTlsM24xb2EyNzgvaXFWNFVZeVRrTFVVdlRHcnU4U1hQN3VjPQ==</success>

2019-11-27 19:31:28 | user :: user_9i2mck0029@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="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost >> <iq xmlns="jabber:client" id="IJSOMyj17GBjRcQRLWS9KKK" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost << <iq id="IJSOMyj17GBjRcQRLWS9KKK" to="user_9i2mck0029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_9i2mck0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="Z6XkU4gXn7oU4BgMAdwcoZn" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost/993927746-tigase-21 << <iq id="Z6XkU4gXn7oU4BgMAdwcoZn" to="user_9i2mck0029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result"/>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="294zvasaNEy8jIAaxt1udxj" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost/993927746-tigase-21 << <enabled id="81822d3a-89b4-457b-8722-b176119aa75d" max="60" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost/993927746-tigase-21 >> <iq id="CRayzcEkHu8gJRN2jJHSczb" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost/993927746-tigase-21 << <iq id="294zvasaNEy8jIAaxt1udxj" to="user_9i2mck0029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server" 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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost/993927746-tigase-21 << <iq id="CRayzcEkHu8gJRN2jJHSczb" to="user_9i2mck0029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:31:28 | Disconnecting

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

2019-11-27 19:31:28 | [Mutex] notify: [disconnected]

2019-11-27 19:31:28 | [Mutex] received everything.

2019-11-27 19:31:28 | [Mutex] waiting for: [event]

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

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

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04WDhXc0NjWEdoWEY4U2xxbFZ2ZW44UXZlcFR3eWlnWUZORXlZV3RTLHM9SHZhMmhta0pMQ1ZIS1E9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OFg4V3NDY1hHaFhGOFNscWxWdmVuOFF2ZXBUd3lpZ1lGTkV5WVd0UyxwPUREeTBZeWVHQzNrNXA0dXlSWVNpN2NmNmtQcko2U1hodld1UFo4ZnRzcDA9</response>

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

2019-11-27 19:31:28 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:28 | [Mutex] received everything.

2019-11-27 19:31:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:28 | [Mutex] waiting for: [event]

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

2019-11-27 19:31:28 | user :: user_9i2mck0029@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-11-27 19:31:28 | user :: user_9i2mck0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyXzlpMm1jazAwMjkscj1PWTcwVkIwVVNNMDhSM3VOM0FieQ==</auth>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PWTcwVkIwVVNNMDhSM3VOM0FieUMxaU9BQ1hFc2dXdXpTdU1YTldjLHM9dUlCYitXenZPcTExOHc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T1k3MFZCMFVTTTA4UjN1TjNBYnlDMWlPQUNYRXNnV3V6U3VNWE5XYyxwPUJrYXZoZDRuNVFSdWdlRUhPc3p3Z3VUVzQ4TT0=</response>

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

2019-11-27 19:31:28 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:28 | [Mutex] notify: [event, disconnected]

2019-11-27 19:31:28 | [Mutex] received everything.

2019-11-27 19:31:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:28 | [Mutex] waiting for: [event]

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

2019-11-27 19:31:28 | user :: user_9i2mck0029@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-11-27 19:31:28 | user :: user_9i2mck0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyXzlpMm1jazAwMjkscj0yVldjbnJIMUNMckZwalNkak9RVA==</auth>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yVldjbnJIMUNMckZwalNkak9RVFpKOHV5SEhnemZabVAwWHZHa3hwLHM9dUlCYitXenZPcTExOHc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:28 | user :: user_9i2mck0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MlZXY25ySDFDTHJGcGpTZGpPUVRaSjh1eUhIZ3pmWm1QMFh2R2t4cCxwPS9VeXpid3RTYmVpd1lsUjk1V054eXY5K0pOdz0=</response>

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

2019-11-27 19:31:28 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:28 | [Mutex] received everything.

2019-11-27 19:31:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 19:31:28 | [Mutex] waiting for: [event]

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

2019-11-27 19:31:29 | user :: user_9i2mck0029@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-11-27 19:31:29 | user :: user_9i2mck0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyXzlpMm1jazAwMjkscj1uaVhocGwyZVBEQmZ6MlA5QlNZaQ==</auth>

2019-11-27 19:31:29 | user :: user_9i2mck0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uaVhocGwyZVBEQmZ6MlA5QlNZaVJZanVaNnNQQXdYc2xVZlFEeHYyLHM9dUlCYitXenZPcTExOHc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:29 | user :: user_9i2mck0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bmlYaHBsMmVQREJmejJQOUJTWWlSWWp1WjZzUEF3WHNsVWZRRHh2MixwPUo0UXZkbXRsUTdVOTdCdmU4MFc4R1l1VUNPUT0=</response>

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

2019-11-27 19:31:29 | [Mutex] notify: [event, authFailed]

2019-11-27 19:31:29 | [Mutex] received everything.

2019-11-27 19:31:29 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-27 19:31:29 | user :: user_9i2mck0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DWnNLVWVtVkJkTTFTblVwVzFMajI0NUc1SXZUeDBlOEtROTl2em5PLHM9SHZhMmhta0pMQ1ZIS1E9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:29 | user :: user_9i2mck0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q1pzS1VlbVZCZE0xU25VcFcxTGoyNDVHNUl2VHgwZThLUTk5dnpuTyxwPVdTeHlYejFHbGJXN1FsRTFEbmFPNW1mUlFDa2tBNVBmSDJtdHRVVGFTKzA9</response>

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

2019-11-27 19:31:31 | [Mutex] waiting for: [user]

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

2019-11-27 19:31:31 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-27 19:31:31 |

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

2019-11-27 19:31:31 | ------------------------------------

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@70d68f00

2019-11-27 19:31:31 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@71909db4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7e116f6a}, 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@7a2ee470}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3f2c6551}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bc6433b}, 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=Wed Nov 27 19:31:31 PST 2019}}}}

2019-11-27 19:31:31 | [Mutex] waiting for: [registration]

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@e591916

2019-11-27 19:31:31 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7e116f6a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@7a2ee470}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3f2c6551}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bc6433b}, 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=Wed Nov 27 19:31:31 PST 2019}}}}

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@35961c9

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

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

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

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1695c55e

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5042ef33

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

2019-11-27 19:31:31 | 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-11-27 19:31:31 | user :: null >> <iq to="localhost" id="Nb27GBjRcQRLWS9KKKCFNX4" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 19:31:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@cad89e93}

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

2019-11-27 19:31:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5b4d21a4}

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@63caa0a6

2019-11-27 19:31:31 | user :: null >> <iq to="localhost" id="fNQR7j4nRXoeDj24xwiQO3z" type="set"><query xmlns="jabber:iq:register"><username>user_jv6bwp0030</username><password>user_jv6bwp0030</password><email>eded0129-8b74-453e-b1b4-0d9d8f7a03a8@localhost</email></query></iq>

2019-11-27 19:31:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8ac2c34f}

2019-11-27 19:31:31 | user :: null << <iq id="fNQR7j4nRXoeDj24xwiQO3z" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-27 19:31:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2436e09b}

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

2019-11-27 19:31:31 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 19:31:31 | 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;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5f039a1e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@185d8bdb]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7e116f6a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@7a2ee470}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3f2c6551}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bc6433b}, 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=Wed Nov 27 19:31:31 PST 2019}}}}

2019-11-27 19:31:31 | 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;@71909db4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5f039a1e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@185d8bdb]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7e116f6a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@30ad978f}, 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@7a2ee470}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3f2c6551}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bc6433b}, 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=Wed Nov 27 19:31:31 PST 2019}}}}

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5041a495

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6233ff38

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@54cabc48

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@47ebac72

2019-11-27 19:31:31 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1a53dd16

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

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

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yTnZwS2hpOG9DZ2kxb2ljUTcxVVJGZEZQTWNOdWZZdllxWE1mOXgwLHM9Sm5Rbk1nRjU2V0ExNWc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ck52cEtoaThvQ2dpMW9pY1E3MVVSRmRGUE1jTnVmWXZZcVhNZjl4MCxwPXc0dVc1TzVYaGNiQlRzczV2MnM1TUxkZGZSb0xheHRDY2FGMEhLTmF3dDg9</response>

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1yQkgvMDU0UEZEZmlTUXh5dGVhSHNhSlQxU0xzR1hrejZCNUExdndKNmk0PQ==</success>

2019-11-27 19:31:31 | user :: user_jv6bwp0030@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="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost >> <iq xmlns="jabber:client" id="v4Du6DJPOKKXYcqTSUOP3bO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="a5EiDmSKHNFMNHDKW39IqfW" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost/993927746-tigase-22 << <iq id="a5EiDmSKHNFMNHDKW39IqfW" to="user_jv6bwp0030@localhost/993927746-tigase-22" xmlns="jabber:client" type="result"/>

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="1YhXn7oU4BgMAdwcoZnP6rZ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost/993927746-tigase-22 << <enabled id="b2681457-a6a9-4452-a031-c809c5970b6b" max="60" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost/993927746-tigase-22 >> <iq id="B1oS0t0gy9oWSXjHQVX9M0b" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost/993927746-tigase-22 << <iq id="B1oS0t0gy9oWSXjHQVX9M0b" to="user_jv6bwp0030@localhost/993927746-tigase-22" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:31:31 | Disconnecting

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost/993927746-tigase-22 << <iq id="1YhXn7oU4BgMAdwcoZnP6rZ" to="user_jv6bwp0030@localhost/993927746-tigase-22" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server" 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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

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

2019-11-27 19:31:31 | [Mutex] notify: [disconnected]

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

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

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

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

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TOW9RR1E3OEJGWWU1WmJST0xNaTh0WVo0YXdoc2FkaVhGRFdXVXFQLHM9Sm5Rbk1nRjU2V0ExNWc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UzlvUUdRNzhCRlllNVpiUk9MTWk4dFlaNGF3aHNhZGlYRkRXV1VxUCxwPTJIcnFGcU9tMzZCZFRQcmtac3owZFZtNFFjL2RJRXN6L253RGJaZ3FreEE9</response>

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

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

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

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

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

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

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

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yRFczbnE5UG1kbTBxTzNSNFdMV3BSRkcyRG9BOU95M0dFWjZheXFoLHM9Sm5Rbk1nRjU2V0ExNWc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MkRXM25xOVBtZG0wcU8zUjRXTFdwUkZHMkRvQTlPeTNHRVo2YXlxaCxwPWVma0tNSElReTg4bWszRjZQeWJNNUNkQlk4S0tDMWVyOWdPdHdUaGt6QXc9</response>

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

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

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

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

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

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

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

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SUDBhNGRxUnF5dnR1aURqZnlpR1hzQ0VsTWs0Z3dMSXNndW54ZlVBLHM9Sm5Rbk1nRjU2V0ExNWc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:31 | user :: user_jv6bwp0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UlAwYTRkcVJxeXZ0dWlEamZ5aUdYc0NFbE1rNGd3TElzZ3VueGZVQSxwPTlzODhSSUVIcmNLNmZqYTFoWWNweUNXbHJkSkNrZzYzc2Jzc1BSWU16SE09</response>

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

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

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

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

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

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

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00RDRCYzNOdjhYTkk1ZnRkeXZOOVJLM1pudnJEUnpncTBwTlQ3RGFJLHM9Sm5Rbk1nRjU2V0ExNWc9PSxpPTQwOTY=</challenge>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NEQ0QmMzTnY4WE5JNWZ0ZHl2TjlSSzNabnZyRFJ6Z3EwcE5UN0RhSSxwPUl5RU9yRUdNb1MycW5LdkZBUGFmamNDek90QnFDMG5yVHBDVjkvZnZyeXc9</response>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj10azU1bm4xdDBzdlZma3BQWmZwb3ZGQ2xoNm5QVDZscUE3Vkw1Mjhya1pBPQ==</success>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@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="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost >> <iq xmlns="jabber:client" id="Tmnav3w2to2kMZrfEq6Fo26" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost << <iq id="Tmnav3w2to2kMZrfEq6Fo26" to="user_jv6bwp0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_jv6bwp0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="2kfVdAiQ9mYYZ4iAn9ncDnZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost/993927746-tigase-23 << <iq id="2kfVdAiQ9mYYZ4iAn9ncDnZ" to="user_jv6bwp0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result"/>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="3nm3gEyzcEkHu8gJRN2jJHS" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost/993927746-tigase-23 << <enabled id="698dfa26-0436-4c86-9198-91f30b46a366" max="60" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost/993927746-tigase-23 >> <iq id="kaHtbQ8rVgwrkU4gXn7oU4B" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost/993927746-tigase-23 << <iq id="3nm3gEyzcEkHu8gJRN2jJHS" to="user_jv6bwp0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server" 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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-27 19:31:32 | user :: user_jv6bwp0030@localhost/993927746-tigase-23 << <iq id="kaHtbQ8rVgwrkU4gXn7oU4B" to="user_jv6bwp0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:31:32 | Disconnecting

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

2019-11-27 19:31:32 | [Mutex] notify: [disconnected]

2019-11-27 19:31:32 | [Mutex] received everything.

2019-11-27 19:31:34 | [Mutex] waiting for: [user]

2019-11-27 19:31:34 | [Mutex] received everything.

2019-11-27 19:31:34 | [Mutex] isItemNotified: user:ok:true :: true