Brute Force Prevention

2019-11-27 18:55:03 |

2019-11-27 18:55:03 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-27 18:55:03 | ------------------------------------

2019-11-27 18:55:03 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2a800c82

2019-11-27 18:55:03 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2447f7a2}, 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@207867f2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@657afd99}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4fb419a8}, 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 18:55:03 PST 2019}}}}

2019-11-27 18:55:03 | [Mutex] waiting for: [registration]

2019-11-27 18:55:03 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@54d51d1b

2019-11-27 18:55:03 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2447f7a2}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@207867f2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@657afd99}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4fb419a8}, 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 18:55:03 PST 2019}}}}

2019-11-27 18:55:03 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@37f1a784

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

2019-11-27 18:55:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@55502d6}

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

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

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

2019-11-27 18:55:03 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6a43228d

2019-11-27 18:55:03 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1682d71b

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

2019-11-27 18:55:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2cf58fc8}

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

2019-11-27 18:55:03 | user :: null >> <iq to="localhost" id="XQNXl2kLU5whGOMzBvbGzBu" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 18:55:03 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@27ac0424}

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

2019-11-27 18:55:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@11b7b32}

2019-11-27 18:55:03 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@723f76d6

2019-11-27 18:55:03 | user :: null >> <iq to="localhost" id="3LwfCGw3zr3q3zqQbP3Bs3y" type="set"><query xmlns="jabber:iq:register"><username>user_t1yd5c0027</username><password>user_t1yd5c0027</password><email>f1025159-9e29-4491-b55c-5e101183f3ea@localhost</email></query></iq>

2019-11-27 18:55:03 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5b68b531}

2019-11-27 18:55:03 | user :: null << <iq id="3LwfCGw3zr3q3zqQbP3Bs3y" from="localhost" xmlns="jabber:client" type="result"/>

2019-11-27 18:55:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@72855d85}

2019-11-27 18:55:03 | [Mutex] received everything.

2019-11-27 18:55:03 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 18:55:03 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@55502d6, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2cf58fc8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2447f7a2}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@207867f2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@657afd99}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4fb419a8}, 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 18:55:03 PST 2019}}}}

2019-11-27 18:55:03 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@55502d6, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2cf58fc8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2447f7a2}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@207867f2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@657afd99}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4fb419a8}, 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 18:55:03 PST 2019}}}}

2019-11-27 18:55:03 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@728e17d2

2019-11-27 18:55:03 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2816205a

2019-11-27 18:55:03 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@21967a48

2019-11-27 18:55:03 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@79a7728a

2019-11-27 18:55:04 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7b15daeb

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1qWkgyY0g5VmJvYlpBRWxHbnZ6NQ==</auth>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qWkgyY0g5VmJvYlpBRWxHbnZ6NVF3ZWU1cHRZRnlkWGdRVHhQZll2LHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9alpIMmNIOVZib2JaQUVsR252ejVRd2VlNXB0WUZ5ZFhnUVR4UGZZdixwPW42ZHNGYU1ZdnpkZHhVb1VnNGdRY09YVThaSWNGT0VXa0paVWdueDBROG89</response>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1vYWsxSGxPckROSjBETkcwVlN1Y29mNzVkaGIvenlpekc5MDd6cDRwM1ZvPQ==</success>

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

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <iq xmlns="jabber:client" id="2HiU3eUYXn3hSXn24DJRdGv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <iq id="2HiU3eUYXn3hSXn24DJRdGv" to="user_t1yd5c0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_t1yd5c0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="CTQODJLHIDJKutpdV6l8iSc" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost/993927746-tigase-19 << <iq id="CTQODJLHIDJKutpdV6l8iSc" to="user_t1yd5c0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result"/>

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

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

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost/993927746-tigase-19 << <enabled id="aec801fc-a856-4b70-816d-38d453b4f4a7" xmlns="urn:xmpp:sm:3" max="60" resume="true" location="d4270859fb27"/>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost/993927746-tigase-19 >> <iq id="HE3oZrak9LVlW1u0i2wrjYc" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost/993927746-tigase-19 << <iq id="HE3oZrak9LVlW1u0i2wrjYc" to="user_t1yd5c0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 18:55:04 | Disconnecting

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

2019-11-27 18:55:04 | [Mutex] notify: [disconnected]

2019-11-27 18:55:04 | [Mutex] received everything.

2019-11-27 18:55:04 | [Mutex] waiting for: [event]

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1MemtuSDJCY2gzRmFUWktabFBEYw==</auth>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MemtuSDJCY2gzRmFUWktabFBEY0N2YnhQaG9PRGtJYVpmWDZ5UXgyLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9THprbkgyQmNoM0ZhVFpLWmxQRGNDdmJ4UGhvT0RrSWFaZlg2eVF4MixwPWJXM1dmTERoMEM4VFdzeDArU3pObUwzY21qeENwVDg4cjBub2RualdZRU09</response>

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

2019-11-27 18:55:04 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:04 | [Mutex] received everything.

2019-11-27 18:55:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:04 | [Mutex] waiting for: [event]

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1lc285NWdYNWx3RzBwcGNFcm1mZg==</auth>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lc285NWdYNWx3RzBwcGNFcm1mZmhQdlpGZ1R4amFYeTdCZXNsSVA3LHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZXNvOTVnWDVsd0cwcHBjRXJtZmZoUHZaRmdUeGphWHk3QmVzbElQNyxwPS9aMjl5OGhjVi9temxvVys5WnlpUnRmQUNVYy9DdEtBd2sxVzVoczBJL1E9</response>

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

2019-11-27 18:55:04 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:04 | [Mutex] received everything.

2019-11-27 18:55:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:04 | [Mutex] waiting for: [event]

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1iejlyWndmRnZ1SmdCSjJYVURjUw==</auth>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iejlyWndmRnZ1SmdCSjJYVURjU01hREdPWXJxa0xpdUsydmtYbzlWLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Yno5clp3ZkZ2dUpnQkoyWFVEY1NNYURHT1lycWtMaXVLMnZrWG85VixwPU55R2hUYmltY0VJcU5VSWNsTU9ZeGVxa0xRTEpUa3pPWFJwRWtSclF1ZnM9</response>

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

2019-11-27 18:55:04 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:04 | [Mutex] received everything.

2019-11-27 18:55:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:04 | [Mutex] waiting for: [event]

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1Xamk5V2ZkYXg4ZEFjM29MWW43NA==</auth>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Xamk5V2ZkYXg4ZEFjM29MWW43NFRjOUQ2OFlXNTVJSzh0T3NiSFdTLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V2ppOVdmZGF4OGRBYzNvTFluNzRUYzlENjhZVzU1SUs4dE9zYkhXUyxwPWo4djdTdjVsNFBITFBubHF1QjZGazR5MkVvenorWFh2MGVJSjVsZ2FHWEU9</response>

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

2019-11-27 18:55:04 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:04 | [Mutex] notify: [event, disconnected]

2019-11-27 18:55:04 | [Mutex] received everything.

2019-11-27 18:55:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:04 | [Mutex] waiting for: [event]

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1NZ1JPQVV3bXlwQ08yWVJYRkdHOQ==</auth>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NZ1JPQVV3bXlwQ08yWVJYRkdHOWVjenp3SUdzMU9HUlNqQTlXZnJpLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TWdST0FVd215cENPMllSWEZHRzllY3p6d0lHczFPR1JTakE5V2ZyaSxwPVhXbXB2dzc4VTJ2UEZNaTRoYzdtWmxoTVZxZW9KYjBGRTdsYTBBM1BsU1U9</response>

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

2019-11-27 18:55:04 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:04 | [Mutex] received everything.

2019-11-27 18:55:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:04 | [Mutex] waiting for: [event]

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:04 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1icm1XVXdua3EzOFlXYkhjT2NTQw==</auth>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1icm1XVXdua3EzOFlXYkhjT2NTQ3A0ekdBb3dHbnFuQkdxalFwc2xPLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YnJtV1V3bmtxMzhZV2JIY09jU0NwNHpHQW93R25xbkJHcWpRcHNsTyxwPXJDYkwzenNad2JRL2w3TFVEeVdYaXg1U2Y5VWJ5cGQxUFpwejZic3QxOHM9</response>

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

2019-11-27 18:55:05 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:05 | [Mutex] received everything.

2019-11-27 18:55:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:05 | [Mutex] waiting for: [event]

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj04QVZtcTQ1cG54ZGlVSkxFTzkxeg==</auth>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04QVZtcTQ1cG54ZGlVSkxFTzkxejJ2Qkpzb3JMdzhGazlWZkJyVXpKLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OEFWbXE0NXBueGRpVUpMRU85MXoydkJKc29yTHc4Rms5VmZCclV6SixwPWVSZkFwSkpsOGJQVnQyZUFjblRiVVBGMFZnd2RmK0lkTDI5ampOVTRQN009</response>

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

2019-11-27 18:55:05 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:05 | [Mutex] received everything.

2019-11-27 18:55:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:05 | [Mutex] notify: [event, disconnected]

2019-11-27 18:55:05 | [Mutex] waiting for: [event]

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1Zd2xSNFRQbXFRSGxLNXR0VXBzNg==</auth>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Zd2xSNFRQbXFRSGxLNXR0VXBzNnFLYzdVazlyUXg1aWZST2ZHV1R3LHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WXdsUjRUUG1xUUhsSzV0dFVwczZxS2M3VWs5clF4NWlmUk9mR1dUdyxwPW5qMDdRdGd6cGQrdjZjaGVFVTlqRFltT2QrNTIvcDBPOGhJMWxmbkxYdUk9</response>

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

2019-11-27 18:55:05 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:05 | [Mutex] received everything.

2019-11-27 18:55:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:05 | [Mutex] waiting for: [event]

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj0xbDY5RmZsT3o4T2h1TG5sdnJaYQ==</auth>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xbDY5RmZsT3o4T2h1TG5sdnJaYUZLZE00OEdwdTU5Q3ZncTBZM0tCLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MWw2OUZmbE96OE9odUxubHZyWmFGS2RNNDhHcHU1OUN2Z3EwWTNLQixwPS8zdGFqQWdCZ1ZpS0pTUzE3R1Uva1BuK0RoQm9UNkFnWDN4MGpCUC8yODg9</response>

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

2019-11-27 18:55:05 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:05 | [Mutex] received everything.

2019-11-27 18:55:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:05 | [Mutex] waiting for: [event]

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1obUl6ZkNYVjEwV1hpY3BadmYwNg==</auth>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1obUl6ZkNYVjEwV1hpY3BadmYwNmVKVEgzUHVGSEgwakdkVzRkbllqLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aG1JemZDWFYxMFdYaWNwWnZmMDZlSlRIM1B1RkhIMGpHZFc0ZG5ZaixwPVlsZndaYVdYSHhEYTdxbUxCbnl1L041R2VEeDZtd2hhWS9EZ1NhSG5zSlk9</response>

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

2019-11-27 18:55:05 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:05 | [Mutex] received everything.

2019-11-27 18:55:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:05 | [Mutex] waiting for: [event]

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1YS2N1RlpEUHFYTGtoc1lTM2ZBNA==</auth>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YS2N1RlpEUHFYTGtoc1lTM2ZBNGFwaFpUQzNrT1NnRlZqaDFNRzZ6LHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WEtjdUZaRFBxWExraHNZUzNmQTRhcGhaVEMza09TZ0ZWamgxTUc2eixwPU1PclROeVVxTVhJMVQ1MndIc0JzWlZ3UFZIZytKeHZwcE9oeVNnUkd4Yms9</response>

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

2019-11-27 18:55:05 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:05 | [Mutex] received everything.

2019-11-27 18:55:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:05 | [Mutex] notify: [event, disconnected]

2019-11-27 18:55:05 | [Mutex] waiting for: [event]

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1MRWRpYVRIdDNIclZtSDZGQmtXOA==</auth>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MRWRpYVRIdDNIclZtSDZGQmtXOFlYVkZlazhnNVRzbEJVTklLN0RDLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TEVkaWFUSHQzSHJWbUg2RkJrVzhZWFZGZWs4ZzVUc2xCVU5JSzdEQyxwPWRRczRJUy9oUG5GSVZBajBvUEtUQW92TENVTWptc2NKZklwekFmMWY1MnM9</response>

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

2019-11-27 18:55:05 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:05 | [Mutex] received everything.

2019-11-27 18:55:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:05 | [Mutex] waiting for: [event]

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1OQ0FmYUROaGYwWDJnRGhaNEZ4Rg==</auth>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OQ0FmYUROaGYwWDJnRGhaNEZ4RklsMlpZUktWcHZXenNpdzVpQ0NuLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TkNBZmFETmhmMFgyZ0RoWjRGeEZJbDJaWVJLVnB2V3pzaXc1aUNDbixwPTV1UEQrbFBPbHRHWmJxeFc3KzRFcGxybUNrcElLOGJPN2V0cFZsaUk0Z2M9</response>

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

2019-11-27 18:55:05 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:05 | [Mutex] received everything.

2019-11-27 18:55:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:05 | [Mutex] waiting for: [event]

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:05 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1jY3RleUEyQmd0TUNnV29BYkdhbw==</auth>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jY3RleUEyQmd0TUNnV29BYkdhb2dOSURQNUZGT2U5bDVXVGhmQkRyLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y2N0ZXlBMkJndE1DZ1dvQWJHYW9nTklEUDVGRk9lOWw1V1RoZkJEcixwPUlVSnZlczQwZjlxTlE3M2dkcFlsQWlzdDVjeGFvWVZjdHdFY0JQWmI5Ujg9</response>

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

2019-11-27 18:55:06 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:06 | [Mutex] received everything.

2019-11-27 18:55:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:06 | [Mutex] waiting for: [event]

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1KZDVzc052dmJvdVVLOGoxZGl0Uw==</auth>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KZDVzc052dmJvdVVLOGoxZGl0U1RubzFMZDlDbFprT2RmWFd1ZEpxLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SmQ1c3NOdnZib3VVSzhqMWRpdFNUbm8xTGQ5Q2xaa09kZlhXdWRKcSxwPWZGRGZaSXpReFZwaU9PYyt5cXBDNllxT0tIQUlaaDliUVR1OFZJeDNRSTg9</response>

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

2019-11-27 18:55:06 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:06 | [Mutex] received everything.

2019-11-27 18:55:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:06 | [Mutex] waiting for: [event]

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj11ZVQxVVRLcFI0dmZaZkpIR0IwaQ==</auth>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11ZVQxVVRLcFI0dmZaZkpIR0IwaXg2ZlppUXFwMXFCSVRJU3B3SzZsLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWVUMVVUS3BSNHZmWmZKSEdCMGl4NmZaaVFxcDFxQklUSVNwd0s2bCxwPXp6TDJrYTRiMkJvelZyS3lGNm1qeWxUZ0xDamtYQm5LL3UzVE54ckE3azg9</response>

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

2019-11-27 18:55:06 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:06 | [Mutex] received everything.

2019-11-27 18:55:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:06 | [Mutex] waiting for: [event]

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1nWnh0RFJscWx4dFpGY281OXdJZw==</auth>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nWnh0RFJscWx4dFpGY281OXdJZ2R3dXRLekhXS1NyN2s4MDBsckVILHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z1p4dERSbHFseHRaRmNvNTl3SWdkd3V0S3pIV0tTcjdrODAwbHJFSCxwPWtmVlIvaE9HbUw5YzFnQ212SnZ6emJVZ1ZrZnRGU3JUNWY1MVBiTFFpRDA9</response>

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

2019-11-27 18:55:06 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:06 | [Mutex] notify: [event, disconnected]

2019-11-27 18:55:06 | [Mutex] received everything.

2019-11-27 18:55:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:06 | [Mutex] waiting for: [event]

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1US09kS0RvcE5FNlh4QjhVT1Q5ag==</auth>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1US09kS0RvcE5FNlh4QjhVT1Q5anlmZzlJcjZJSjFreVVMQVl2RmliLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VEtPZEtEb3BORTZYeEI4VU9UOWp5Zmc5SXI2SUoxa3lVTEFZdkZpYixwPWFZU1pHdUFnRDdiSm42SW51dmh0UXdORWVWTFJGdVJaK0FrbjdXcnRjMW89</response>

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

2019-11-27 18:55:06 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:06 | [Mutex] received everything.

2019-11-27 18:55:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:06 | [Mutex] waiting for: [event]

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj13aUw1M0pKSkJFQWZnNG9UMDFrbw==</auth>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13aUw1M0pKSkJFQWZnNG9UMDFrb1FYU3RnZ09CYzdpa2hZWGF4NlVyLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d2lMNTNKSkpCRUFmZzRvVDAxa29RWFN0Z2dPQmM3aWtoWVhheDZVcixwPVZmK2tlOVlUeWFCSUdlMjhMb0NjaFBSZER0elZTYjdOWWc5d2dJZVdjNWc9</response>

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

2019-11-27 18:55:06 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:06 | [Mutex] received everything.

2019-11-27 18:55:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:06 | [Mutex] notify: [event, disconnected]

2019-11-27 18:55:06 | [Mutex] waiting for: [event]

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1QclRBcENhOVBSc0M2MjlkUG1FRw==</auth>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QclRBcENhOVBSc0M2MjlkUG1FRzBlRjNPMnpmZkdSSVZTS1prUldSLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UHJUQXBDYTlQUnNDNjI5ZFBtRUcwZUYzTzJ6ZmZHUklWU0taa1JXUixwPUg5L0phcm9KK3FyendhWTNGMVdVMkJQOUNFYnJTeVVvR1BlVDMzWG5WVXc9</response>

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

2019-11-27 18:55:06 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:06 | [Mutex] received everything.

2019-11-27 18:55:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:06 | [Mutex] waiting for: [event]

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1seHprYmZDeWJOZW1LZ0pWWllCUw==</auth>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1seHprYmZDeWJOZW1LZ0pWWllCU2pDcjlJdW51QWE3OGZxbjNNTHplLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bHh6a2JmQ3liTmVtS2dKVlpZQlNqQ3I5SXVudUFhNzhmcW4zTUx6ZSxwPTE4bElOMmxJMWl3K3d1L21ibGdVbHJqS0hkc2U4dU8vY2pZVW52S3owK3c9</response>

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

2019-11-27 18:55:06 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:06 | [Mutex] received everything.

2019-11-27 18:55:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3QxeWQ1YzAwMjcscj1PRzZlUGYxUDI4U0c4TklEYWtJVw==</auth>

2019-11-27 18:55:06 | user :: user_t1yd5c0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PRzZlUGYxUDI4U0c4TklEYWtJVzVxYnNYQVdPTnF2ZWJlYnRiZ2ZnLHM9Z1RNNGk4Y0hpTkJkT0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:07 | user :: user_t1yd5c0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T0c2ZVBmMVAyOFNHOE5JRGFrSVc1cWJzWEFXT05xdmViZWJ0YmdmZyxwPURnNno4M2FFUmhvVGl0aS8vdWw2bjYwUlNrVStiN3lJV3JWdDdKZDdwaHM9</response>

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

2019-11-27 18:55:09 | [Mutex] waiting for: [user]

2019-11-27 18:55:09 | [Mutex] received everything.

2019-11-27 18:55:09 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-27 18:55:09 |

2019-11-27 18:55:09 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-27 18:55:09 | ------------------------------------

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7cdc8d0b

2019-11-27 18:55:09 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@721b6ce0}, 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@7624e67b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@332666db}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b8a0161}, 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 18:55:09 PST 2019}}}}

2019-11-27 18:55:09 | [Mutex] waiting for: [registration]

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@25f149c

2019-11-27 18:55:09 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@721b6ce0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@7624e67b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@332666db}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b8a0161}, 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 18:55:09 PST 2019}}}}

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@53192d92

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

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

2019-11-27 18:55:09 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@53099994}

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

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

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@28f30b9d

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@527211eb

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

2019-11-27 18:55:09 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@481dc38a}

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

2019-11-27 18:55:09 | user :: null >> <iq to="localhost" id="RMlN26uqiZpaAhW9ExcQQHR" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 18:55:09 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e684a9b6}

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

2019-11-27 18:55:09 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@57472624}

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@67d860b2

2019-11-27 18:55:09 | user :: null >> <iq to="localhost" id="sWNZkUVeJORQ8qRbFvkRbEi" type="set"><query xmlns="jabber:iq:register"><username>user_hncgf10028</username><password>user_hncgf10028</password><email>ecf64a95-3efd-4027-ab5f-459e3fd43233@localhost</email></query></iq>

2019-11-27 18:55:09 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@62fc4d2e}

2019-11-27 18:55:09 | user :: null << <iq id="sWNZkUVeJORQ8qRbFvkRbEi" from="localhost" xmlns="jabber:client" type="result"/>

2019-11-27 18:55:09 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2567d8eb}

2019-11-27 18:55:09 | [Mutex] received everything.

2019-11-27 18:55:09 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 18:55:09 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@53099994, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@481dc38a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@721b6ce0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@7624e67b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@332666db}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b8a0161}, 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 18:55:09 PST 2019}}}}

2019-11-27 18:55:09 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@53099994, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@481dc38a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@721b6ce0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@7624e67b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@332666db}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b8a0161}, 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 18:55:09 PST 2019}}}}

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3404e5e

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6d583e14

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@49211efd

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@529a27b2

2019-11-27 18:55:09 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@53a9b101

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2huY2dmMTAwMjgscj0yakVQa0lkeVJzdU1taFQyWTBmMA==</auth>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yakVQa0lkeVJzdU1taFQyWTBmMGo0bXVqd0ZJbU5pdDFxMGpReEtmLHM9NS83MWhqRnNNbk9Ra0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MmpFUGtJZHlSc3VNbWhUMlkwZjBqNG11andGSW1OaXQxcTBqUXhLZixwPVNjNUFzMEpHWGxsMnBUWGR6Q21OTHFaclp0UFRKWHNJWWZMREhvT0hueTg9</response>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1pRnZvcTloNjAzczlLWnVKWDNKUnNXV21meUJLNlBicHRtMnFlU0pZK1owPQ==</success>

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

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <iq xmlns="jabber:client" id="oAHEKWhZkUVeJORQ8qRbFvk" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <iq id="oAHEKWhZkUVeJORQ8qRbFvk" to="user_hncgf10028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_hncgf10028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="UBIGO4xvmY3ufQVYoWTfNLQ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost/993927746-tigase-20 << <iq id="UBIGO4xvmY3ufQVYoWTfNLQ" to="user_hncgf10028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result"/>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost/993927746-tigase-20 >> <iq to="localhost" id="T2ZYeUgVhU4fS1o1aMIrlZ9" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost/993927746-tigase-20 << <enabled id="cfa15766-f28c-4f25-8cbf-09cc9177a86a" xmlns="urn:xmpp:sm:3" max="60" resume="true" location="d4270859fb27"/>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost/993927746-tigase-20 >> <iq id="BJ2u8h1lR2h1kEN3vvgFMAs" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost/993927746-tigase-20 << <iq id="BJ2u8h1lR2h1kEN3vvgFMAs" to="user_hncgf10028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 18:55:09 | Disconnecting

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

2019-11-27 18:55:09 | [Mutex] notify: [disconnected]

2019-11-27 18:55:09 | [Mutex] received everything.

2019-11-27 18:55:09 | [Mutex] waiting for: [event]

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2huY2dmMTAwMjgscj1DVDNmUUZpNmloYUk1aEhEMEVjYQ==</auth>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DVDNmUUZpNmloYUk1aEhEMEVjYW53RHBHZEpyUzRURkF1RFVxZm1lLHM9NS83MWhqRnNNbk9Ra0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q1QzZlFGaTZpaGFJNWhIRDBFY2Fud0RwR2RKclM0VEZBdURVcWZtZSxwPTBjdVZZUXBsZllYMnVqQW0xd0xXVm56aEtQQkFtUnpHOXFsREZtZzNCTjg9</response>

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

2019-11-27 18:55:09 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:09 | [Mutex] received everything.

2019-11-27 18:55:09 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:09 | [Mutex] waiting for: [event]

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2huY2dmMTAwMjgscj1lV3M3WVpYNGJwckVuSTdaeklnRw==</auth>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lV3M3WVpYNGJwckVuSTdaeklnR3JxeFU0dkw1YWl5SjM0enphYUlpLHM9NS83MWhqRnNNbk9Ra0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZVdzN1laWDRicHJFbkk3WnpJZ0dycXhVNHZMNWFpeUozNHp6YWFJaSxwPWZGcEFtMGw4ZnljN0Rja3FPT3lrMEFDV0w2UloyTkkyQkpMSjV0N2lQTkU9</response>

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

2019-11-27 18:55:09 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:09 | [Mutex] received everything.

2019-11-27 18:55:09 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:09 | [Mutex] waiting for: [event]

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2huY2dmMTAwMjgscj1SZURYT3BzeDd6eEhZRUpiREVDNw==</auth>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SZURYT3BzeDd6eEhZRUpiREVDN3Y1MUxNbWd0TU02RFZDTHB0c2JhLHM9NS83MWhqRnNNbk9Ra0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UmVEWE9wc3g3enhIWUVKYkRFQzd2NTFMTW1ndE1NNkRWQ0xwdHNiYSxwPXdKZDk5em5FMDUwUEw4aXZscEl5M0IrRm9XcjY5U3JDbFRRQllGclZOemc9</response>

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

2019-11-27 18:55:09 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:09 | [Mutex] received everything.

2019-11-27 18:55:09 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:09 | [Mutex] waiting for: [event]

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:09 | user :: user_hncgf10028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:10 | user :: user_hncgf10028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2huY2dmMTAwMjgscj05MXVRY2hVcXFySTJ2MVVheVdORg==</auth>

2019-11-27 18:55:10 | user :: user_hncgf10028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05MXVRY2hVcXFySTJ2MVVheVdORnl0cjNFMGd4bk5ZY3JyMVZGenJPLHM9NS83MWhqRnNNbk9Ra0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:10 | user :: user_hncgf10028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OTF1UWNoVXFxckkydjFVYXlXTkZ5dHIzRTBneG5OWWNycjFWRnpyTyxwPUtoTFpJYXFXN2ZTci9TT3ZKYXc3T1BIL1M0eU9JdXE3SmczbkR1czJVa2M9</response>

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

2019-11-27 18:55:10 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:10 | [Mutex] received everything.

2019-11-27 18:55:10 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-27 18:55:10 | user :: user_hncgf10028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:10 | user :: user_hncgf10028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2huY2dmMTAwMjgscj02UE4xQmVsdW1ZRzBQMmVuQW5CNg==</auth>

2019-11-27 18:55:10 | user :: user_hncgf10028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02UE4xQmVsdW1ZRzBQMmVuQW5CNk5INEdjUENlTEtFREtzczBOc0lzLHM9NS83MWhqRnNNbk9Ra0E9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:10 | user :: user_hncgf10028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NlBOMUJlbHVtWUcwUDJlbkFuQjZOSDRHY1BDZUxLRURLc3MwTnNJcyxwPUdkeFV3cmpmUUVtZVZKMGxxS1VFZWpFUDNleDE5aFB4S256cmk0Sm5DZ1U9</response>

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

2019-11-27 18:55:12 | [Mutex] waiting for: [user]

2019-11-27 18:55:12 | [Mutex] received everything.

2019-11-27 18:55:12 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-27 18:55:12 |

2019-11-27 18:55:12 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-27 18:55:12 | ------------------------------------

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5e12e154

2019-11-27 18:55:12 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@50d504e6}, 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@54ea8a24}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@11e80edd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@58b955f5}, 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 18:55:12 PST 2019}}}}

2019-11-27 18:55:12 | [Mutex] waiting for: [registration]

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@20b39830

2019-11-27 18:55:12 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@50d504e6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@54ea8a24}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@11e80edd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@58b955f5}, 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 18:55:12 PST 2019}}}}

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@20089da8

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

2019-11-27 18:55:12 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@71c7f192}

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

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

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

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@634304a2

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5f0d62e2

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

2019-11-27 18:55:12 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b0c5176}

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

2019-11-27 18:55:12 | user :: null >> <iq to="localhost" id="EFKV9tgJV8g1vpjSTeugYob" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 18:55:12 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@796c2f98}

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

2019-11-27 18:55:12 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@75896ce4}

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@e9410e3

2019-11-27 18:55:12 | user :: null >> <iq to="localhost" id="kadErkGEKWhZkUVeJORQ8qR" type="set"><query xmlns="jabber:iq:register"><username>user_yq7vj50029</username><password>user_yq7vj50029</password><email>9884d15a-064c-45e7-90e9-0cc99d3b3387@localhost</email></query></iq>

2019-11-27 18:55:12 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@32392d7}

2019-11-27 18:55:12 | user :: null << <iq id="kadErkGEKWhZkUVeJORQ8qR" from="localhost" xmlns="jabber:client" type="result"/>

2019-11-27 18:55:12 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3aba79a1}

2019-11-27 18:55:12 | [Mutex] received everything.

2019-11-27 18:55:12 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 18:55:12 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@71c7f192, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b0c5176]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@50d504e6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@54ea8a24}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@11e80edd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@58b955f5}, 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 18:55:12 PST 2019}}}}

2019-11-27 18:55:12 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@71c7f192, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b0c5176]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@50d504e6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@54ea8a24}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@11e80edd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@58b955f5}, 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 18:55:12 PST 2019}}}}

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@63e41861

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@5d34a6b5

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7389a6f8

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1a17ae59

2019-11-27 18:55:12 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@59f38a6a

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lxN3ZqNTAwMjkscj1mV0hKenhCZEFMdW8zNE1UNlpVRg==</auth>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mV0hKenhCZEFMdW8zNE1UNlpVRnRxM2VqMnFNUUJ2VVpMWGZxd0d3LHM9R2VpY3NJT3h2THdLOHc9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZldISnp4QmRBTHVvMzRNVDZaVUZ0cTNlajJxTVFCdlVaTFhmcXdHdyxwPWZhbElVTkxFWW10Y1dqeU5BRTd6QVZFOVhYT1B3a01BR2d6ekM5dnFBNDA9</response>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj11SkdOb3FZMWhHdElYZy9jOTNGOTYyRndtcXRucUNNQlY1dkhWNko1bHdZPQ==</success>

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

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost >> <iq xmlns="jabber:client" id="685iBFDrcBFCeXn9NQP6eKW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost << <iq id="685iBFDrcBFCeXn9NQP6eKW" to="user_yq7vj50029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_yq7vj50029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="MHKXn9NQP6eKWk3xq6j0hU3" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost/993927746-tigase-21 << <iq id="MHKXn9NQP6eKWk3xq6j0hU3" to="user_yq7vj50029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result"/>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost/993927746-tigase-21 >> <iq to="localhost" id="7Sftp7p8tp6cTfThOLYYeUg" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost/993927746-tigase-21 << <enabled id="5f10e448-5e5a-490d-8acd-49cf34287da3" xmlns="urn:xmpp:sm:3" max="60" resume="true" location="d4270859fb27"/>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost/993927746-tigase-21 >> <iq id="8KP5t7yj5sUj5zDwbOEACGL" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost/993927746-tigase-21 << <iq id="8KP5t7yj5sUj5zDwbOEACGL" to="user_yq7vj50029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 18:55:12 | Disconnecting

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

2019-11-27 18:55:12 | [Mutex] notify: [disconnected]

2019-11-27 18:55:12 | [Mutex] received everything.

2019-11-27 18:55:12 | [Mutex] waiting for: [event]

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfeXE3dmo1MDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-27 18:55:12 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:12 | [Mutex] received everything.

2019-11-27 18:55:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:12 | [Mutex] waiting for: [event]

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3lxN3ZqNTAwMjkscj1RN21maWJUYW1uSUpKOWxkMlBSeg==</auth>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RN21maWJUYW1uSUpKOWxkMlBSejhwRE5JSXRhYTR1R0M4NDN3eTFjLHM9Y0I2elVUTTNHN054bHc9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UTdtZmliVGFtbklKSjlsZDJQUno4cEROSUl0YWE0dUdDODQzd3kxYyxwPUhFeEJFeTMwa0xLQTE2RGhQbUgyNU5vd0M5Zz0=</response>

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

2019-11-27 18:55:12 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:12 | [Mutex] received everything.

2019-11-27 18:55:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:12 | [Mutex] waiting for: [event]

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:12 | user :: user_yq7vj50029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:13 | user :: user_yq7vj50029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfeXE3dmo1MDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-27 18:55:13 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:13 | [Mutex] received everything.

2019-11-27 18:55:13 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:13 | [Mutex] waiting for: [event]

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

2019-11-27 18:55:13 | user :: user_yq7vj50029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:13 | user :: user_yq7vj50029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lxN3ZqNTAwMjkscj1FWHcxbE9aY21EZUlwZFZGaU1CYQ==</auth>

2019-11-27 18:55:13 | user :: user_yq7vj50029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FWHcxbE9aY21EZUlwZFZGaU1CYXFKT2tKSUI0R2Rub08yVWJXak1SLHM9R2VpY3NJT3h2THdLOHc9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:13 | user :: user_yq7vj50029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RVh3MWxPWmNtRGVJcGRWRmlNQmFxSk9rSklCNEdkbm9PMlViV2pNUixwPVJ3TlVCRzcxZ3dmMVBOZHpqQmFzMHBNaGliTVB5QmxhNU4rUzRNRXBqNU09</response>

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

2019-11-27 18:55:13 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:13 | [Mutex] received everything.

2019-11-27 18:55:13 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-27 18:55:13 | user :: user_yq7vj50029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:13 | user :: user_yq7vj50029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lxN3ZqNTAwMjkscj1nandzUzJtbWJuN1lSbUVWY1J6SQ==</auth>

2019-11-27 18:55:13 | user :: user_yq7vj50029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nandzUzJtbWJuN1lSbUVWY1J6SW12YktxNGRxdEltTXlreHh3YlF1LHM9R2VpY3NJT3h2THdLOHc9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:13 | user :: user_yq7vj50029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z2p3c1MybW1ibjdZUm1FVmNSekltdmJLcTRkcXRJbU15a3h4d2JRdSxwPTBnNHhyRXNrRG5QV2tEUjNMeEkzWTdkQzhsWDJZSWxOQUU5VER2OUtFUUU9</response>

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

2019-11-27 18:55:15 | [Mutex] waiting for: [user]

2019-11-27 18:55:15 | [Mutex] received everything.

2019-11-27 18:55:15 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-27 18:55:15 |

2019-11-27 18:55:15 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-27 18:55:15 | ------------------------------------

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@8d66bbc

2019-11-27 18:55:15 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@61194d6}, 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@22e00cc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@472c9eed}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c1c863f}, 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 18:55:15 PST 2019}}}}

2019-11-27 18:55:15 | [Mutex] waiting for: [registration]

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@76a11a4e

2019-11-27 18:55:15 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@61194d6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@22e00cc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@472c9eed}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c1c863f}, 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 18:55:15 PST 2019}}}}

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@47b5c36

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

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

2019-11-27 18:55:15 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@270361a2}

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

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

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3fb63603

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@41bb38d1

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

2019-11-27 18:55:15 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f7f563c}

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

2019-11-27 18:55:15 | user :: null >> <iq to="localhost" id="I6NLZgwxxtr8pgyoeUdR4oT" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 18:55:15 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d2eeb235}

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

2019-11-27 18:55:15 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@234d3a00}

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@2d450644

2019-11-27 18:55:15 | user :: null >> <iq to="localhost" id="Pc3zoViCwuqfVcEpcFGBk6m" type="set"><query xmlns="jabber:iq:register"><username>user_pht55j0030</username><password>user_pht55j0030</password><email>1520e19f-0cf5-43c5-8eb9-b35e027fdf04@localhost</email></query></iq>

2019-11-27 18:55:15 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ff434650}

2019-11-27 18:55:15 | user :: null << <iq id="Pc3zoViCwuqfVcEpcFGBk6m" from="localhost" xmlns="jabber:client" type="result"/>

2019-11-27 18:55:15 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3520de8d}

2019-11-27 18:55:15 | [Mutex] received everything.

2019-11-27 18:55:15 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 18:55:15 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@270361a2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f7f563c]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@61194d6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@22e00cc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@472c9eed}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c1c863f}, 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 18:55:15 PST 2019}}}}

2019-11-27 18:55:15 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@270361a2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f7f563c]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@61194d6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@22e00cc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@472c9eed}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c1c863f}, 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 18:55:15 PST 2019}}}}

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@508bb0a3

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1adc0d88

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1f2e5fb1

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2c492e6f

2019-11-27 18:55:15 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@21ca8ded

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BodDU1ajAwMzAscj1vcEpRT2xTWllBSmliTzF0TVZLdA==</auth>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vcEpRT2xTWllBSmliTzF0TVZLdFVNU1VuWjJiRk5XV25pMDVNOVRBLHM9QzMycjRUWHNSRHlVaGc9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b3BKUU9sU1pZQUppYk8xdE1WS3RVTVNVbloyYkZOV1duaTA1TTlUQSxwPVViN09pZG9SMVEzUHM0NWJUYU9MWGlaLzVURXBSNm5tWWJweDNOZXBLV0E9</response>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1iM3lMSDFtcGw3L1pWcVhVM2hGM0dEckFtU1Q0cGJOUmVjeCt1U3VQRG1ZPQ==</success>

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

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost >> <iq xmlns="jabber:client" id="R4Dncq8IS9JOSR6tiPM0al9" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost << <iq id="R4Dncq8IS9JOSR6tiPM0al9" to="user_pht55j0030@localhost/993927746-tigase-22" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_pht55j0030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="a8NJMLZgwxxtr8pgyoeUdR4" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost/993927746-tigase-22 << <iq id="a8NJMLZgwxxtr8pgyoeUdR4" to="user_pht55j0030@localhost/993927746-tigase-22" xmlns="jabber:client" type="result"/>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="ERWjV1mVjUO7HN5qZqS2wun" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost/993927746-tigase-22 >> <iq id="rjgTdMOJQXgLEKEj5t7yj5s" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost/993927746-tigase-22 << <enabled id="c0f1d9b8-745d-4cd7-8a0c-aff7d9cad8a3" xmlns="urn:xmpp:sm:3" max="60" resume="true" location="d4270859fb27"/>

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

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost/993927746-tigase-22 << <iq id="rjgTdMOJQXgLEKEj5t7yj5s" to="user_pht55j0030@localhost/993927746-tigase-22" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 18:55:15 | Disconnecting

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

2019-11-27 18:55:15 | [Mutex] notify: [disconnected]

2019-11-27 18:55:15 | [Mutex] received everything.

2019-11-27 18:55:15 | [Mutex] waiting for: [event]

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:15 | user :: user_pht55j0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BodDU1ajAwMzAscj1lNzVaYXl1SDd4S1VzbGNnVHZBTQ==</auth>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lNzVaYXl1SDd4S1VzbGNnVHZBTVVpY3M0VDVaeG9NeTZzbmVxUUJ5LHM9QzMycjRUWHNSRHlVaGc9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZTc1WmF5dUg3eEtVc2xjZ1R2QU1VaWNzNFQ1WnhvTXk2c25lcVFCeSxwPUdvaytRbUE3eEk4MHNEekNYZEdWN1FpaUpSQWhPWGQ2NnEwM1ZPWWRrYTg9</response>

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

2019-11-27 18:55:16 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:16 | [Mutex] received everything.

2019-11-27 18:55:16 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:16 | [Mutex] waiting for: [event]

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BodDU1ajAwMzAscj1Na1UwVE5NUnRmWUY4b05KaDZVMA==</auth>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Na1UwVE5NUnRmWUY4b05KaDZVMHMyU2s1RFBxZG1sbFFQUTN6OHFtLHM9QzMycjRUWHNSRHlVaGc9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TWtVMFROTVJ0ZllGOG9OSmg2VTBzMlNrNURQcWRtbGxRUFEzejhxbSxwPXBrRnpNQVcwQ1NHKzIveHpnQ092MVVvYytWa3JPQ1NRTWsyTGxWOFVEakE9</response>

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

2019-11-27 18:55:16 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:16 | [Mutex] received everything.

2019-11-27 18:55:16 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:16 | [Mutex] waiting for: [event]

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BodDU1ajAwMzAscj1pMEJERTluQlVpbHpNWXFOdVB6bg==</auth>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pMEJERTluQlVpbHpNWXFOdVB6bngxTDBsWGpMcnV6QVBVR3ZkRFEyLHM9QzMycjRUWHNSRHlVaGc9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aTBCREU5bkJVaWx6TVlxTnVQem54MUwwbFhqTHJ1ekFQVUd2ZERRMixwPUxkZTVRN0ZmL2NIb0s0WlFtWGVHc24ya29UMTh1RTNCMU9wVVBYS1RuUG89</response>

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

2019-11-27 18:55:16 | [Mutex] notify: [event, authFailed]

2019-11-27 18:55:16 | [Mutex] received everything.

2019-11-27 18:55:16 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BodDU1ajAwMzAscj10dTIxY2p2SmV5Z3hlZUNGQTRIZQ==</auth>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10dTIxY2p2SmV5Z3hlZUNGQTRIZW45V0ppUWZnb3R0b09EbjFjY0w4LHM9QzMycjRUWHNSRHlVaGc9PSxpPTQwOTY=</challenge>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dHUyMWNqdkpleWd4ZWVDRkE0SGVuOVdKaVFmZ290dG9PRG4xY2NMOCxwPW9POGhzQjNJZmJ2bG11MHc1djB4ZVdqajBLa1F2QWdUM3RXQkFOZUQ4U009</response>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj05YUM0aUlyekxmbEVsUHY5L2p5SW4ybGpGZkRsVEN0Y1hMV25UMEFNQ1k4PQ==</success>

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

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost >> <iq xmlns="jabber:client" id="m1m8iScQ5BymP2l2jKW25Dz" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost << <iq id="m1m8iScQ5BymP2l2jKW25Dz" to="user_pht55j0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_pht55j0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="6liIrlZ9CrlYWndP9yfWU6E" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost/993927746-tigase-23 << <iq id="6liIrlZ9CrlYWndP9yfWU6E" to="user_pht55j0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result"/>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="d7ABuYrl5FAj4aCGO1tiQNY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost/993927746-tigase-23 << <enabled id="ad6a87dc-7143-4950-aea6-d77fc67a21da" xmlns="urn:xmpp:sm:3" max="60" resume="true" location="d4270859fb27"/>

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost/993927746-tigase-23 >> <iq id="PkbPUXmKM0sj3sargNW7mau" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 18:55:16 | user :: user_pht55j0030@localhost/993927746-tigase-23 << <iq id="PkbPUXmKM0sj3sargNW7mau" to="user_pht55j0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 18:55:16 | Disconnecting

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

2019-11-27 18:55:16 | [Mutex] notify: [disconnected]

2019-11-27 18:55:16 | [Mutex] received everything.

2019-11-27 18:55:18 | [Mutex] waiting for: [user]

2019-11-27 18:55:18 | [Mutex] received everything.

2019-11-27 18:55:18 | [Mutex] isItemNotified: user:ok:true :: true