Brute Force Prevention

2019-12-03 18:55:40 |

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

2019-12-03 18:55:40 | ------------------------------------

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@69f7831c

2019-12-03 18:55:40 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@49cbbe22}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@67307052}, 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@630fe86c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@260d7a69}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7337e2d7}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:40 PST 2019}}}}

2019-12-03 18:55:40 | [Mutex] waiting for: [registration]

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@17e1be03

2019-12-03 18:55:40 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@67307052}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@630fe86c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@260d7a69}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7337e2d7}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:40 PST 2019}}}}

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@b31781b

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

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

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

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@acff66f

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@10c45093

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

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

2019-12-03 18:55:40 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@257a82dc}

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

2019-12-03 18:55:40 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@426cbfa5}

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@37e55509

2019-12-03 18:55:40 | user :: null >> <iq to="localhost" id="XPIvds3gQQ7xr6hAEv4DhGD" type="set"><query xmlns="jabber:iq:register"><username>user_wy56vt0027</username><password>user_wy56vt0027</password><email>c040b83a-4bef-4f14-872a-4805f7284634@localhost</email></query></iq>

2019-12-03 18:55:40 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d6aed3d0}

2019-12-03 18:55:40 | user :: null << <iq type="result" id="XPIvds3gQQ7xr6hAEv4DhGD" from="localhost" xmlns="jabber:client"/>

2019-12-03 18:55:40 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@517dbae}

2019-12-03 18:55:40 | [Mutex] received everything.

2019-12-03 18:55:40 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-03 18:55:40 | 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;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@46228526, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@10351330]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@67307052}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@630fe86c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@260d7a69}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7337e2d7}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:40 PST 2019}}}}

2019-12-03 18:55:40 | 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;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@46228526, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@10351330]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@67307052}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@630fe86c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@260d7a69}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7337e2d7}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:40 PST 2019}}}}

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3d83f4af

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1ab5e52d

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7e5b66f

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3c14d796

2019-12-03 18:55:40 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1e907a37

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

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

2019-12-03 18:55:40 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XelVXQ0hqNTJUdk5kUjkyT0Naa3VBN1FtNTc0dDV2ZzJYckRjdk1qLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:40 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V3pVV0NIajUyVHZOZFI5Mk9DWmt1QTdRbTU3NHQ1dmcyWHJEY3ZNaixwPWk0ay9hNEJyWm1ac1diZDBOd1BlbVYrNVJhZGg2M3dobXh5VVhCT0xvY009</response>

2019-12-03 18:55:40 | user :: user_wy56vt0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1KM0ZzYkZKcGxOdk9BZC9WWDJEM2RuM2Y4YmNsYXM2OEZjekJ3NXJVL1RvPQ==</success>

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

2019-12-03 18:55:40 | user :: user_wy56vt0027@localhost >> <iq xmlns="jabber:client" id="XQJxhAjMSUfNX8lIU16HpW9" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-03 18:55:40 | user :: user_wy56vt0027@localhost << <iq type="result" id="XQJxhAjMSUfNX8lIU16HpW9" to="user_wy56vt0027@localhost/993927746-tigase-19" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_wy56vt0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-12-03 18:55:40 | user :: user_wy56vt0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="guDpVjEw2jZZ8Gt9kNKOMZh" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-03 18:55:40 | user :: user_wy56vt0027@localhost/993927746-tigase-19 << <iq type="result" id="guDpVjEw2jZZ8Gt9kNKOMZh" to="user_wy56vt0027@localhost/993927746-tigase-19" xmlns="jabber:client"/>

2019-12-03 18:55:40 | user :: user_wy56vt0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="6GbpQax8LxcFnVXnMMyl37o" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost/993927746-tigase-19 << <enabled id="856cbc6d-d213-4802-8f5e-3f0b30447623" max="60" resume="true" xmlns="urn:xmpp:sm:3" location="d4270859fb27"/>

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost/993927746-tigase-19 >> <iq id="7yLwwfyBdynNLDJuco1pPO2" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost/993927746-tigase-19 << <iq type="result" id="6GbpQax8LxcFnVXnMMyl37o" from="localhost" to="user_wy56vt0027@localhost/993927746-tigase-19" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost/993927746-tigase-19 << <iq type="result" id="7yLwwfyBdynNLDJuco1pPO2" to="user_wy56vt0027@localhost/993927746-tigase-19" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 18:55:41 | Disconnecting

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

2019-12-03 18:55:41 | [Mutex] notify: [disconnected]

2019-12-03 18:55:41 | [Mutex] received everything.

2019-12-03 18:55:41 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nc3pFcnYyblg2c0ZSWHNBTkNEalUxTlZFcDZTZ2JDblZ1MVJIblR6LHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z3N6RXJ2Mm5YNnNGUlhzQU5DRGpVMU5WRXA2U2diQ25WdTFSSG5UeixwPUQ3emYxUVcxWVgvdHNiTUowSFBDTkZzK3pXRTNIb0JvUjA1c1B4a3VPWEk9</response>

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

2019-12-03 18:55:41 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:41 | [Mutex] received everything.

2019-12-03 18:55:41 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:41 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OYkFyRGdEUWhaYm90QnVEY1NGdEdGOGJpeHNHbjZIMFVabHNidGh2LHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TmJBckRnRFFoWmJvdEJ1RGNTRnRHRjhiaXhzR242SDBVWmxzYnRodixwPTc5V1dqd0ZpZTZtdDZTYTNOUjZnTGN5TmRyRlNrWWE0VEJlNW1ZMFNLTFk9</response>

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

2019-12-03 18:55:41 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:41 | [Mutex] received everything.

2019-12-03 18:55:41 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:41 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YYkdKRllGZjBHckZxQWFScnpGUmlMcDhlMjB2QW9TaGFINm9tVG92LHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WGJHSkZZRmYwR3JGcUFhUnJ6RlJpTHA4ZTIwdkFvU2hhSDZvbVRvdixwPWVyUzV4WGZFVkdiY0RlcGU2b0hQcGJmbFNkMUNtODF4Mkhhc2NBSXlkNlE9</response>

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

2019-12-03 18:55:41 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:41 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:41 | [Mutex] received everything.

2019-12-03 18:55:41 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:41 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DU2llMU1mVWhiMFNDSExjNzM5ZkpYdGdPUkVTNTVzeG1xS09SdGJoLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q1NpZTFNZlVoYjBTQ0hMYzczOWZKWHRnT1JFUzU1c3htcUtPUnRiaCxwPVE1YW8veTFwSWFKcnR0WkVwbDIzLzRTVnc1VXFYd0NaUHNpNWk1NDlyZWc9</response>

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

2019-12-03 18:55:41 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:41 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:41 | [Mutex] received everything.

2019-12-03 18:55:41 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:41 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RTGwySWNhdlN1NVd4cjd3RDdyTjROUFhUYjVxOFdqRnVJQlQ5bkdaLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UUxsMkljYXZTdTVXeHI3d0Q3ck40TlBYVGI1cThXakZ1SUJUOW5HWixwPTBZdWtlTnVVd2pWL2tGdi8xS2pKbVJlcjBZY3grYkNpeXoyKzhDSHV4NnM9</response>

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

2019-12-03 18:55:41 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:41 | [Mutex] received everything.

2019-12-03 18:55:41 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:41 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pQ2xNM2duOXhaQnZhTmFmY2g2TVdhY0RmTTExOWJibVJZeEZad0tsLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:41 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aUNsTTNnbjl4WkJ2YU5hZmNoNk1XYWNEZk0xMTliYm1SWXhGWndLbCxwPTlucHY4dDV5U2tTZVhvUXE2dHJEZ2JnRTd4azFnRE9LdEt5K0NmZE1UZDA9</response>

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

2019-12-03 18:55:41 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:41 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:41 | [Mutex] received everything.

2019-12-03 18:55:41 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:41 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16aVcwcHlreG8zYXREWHdQSk9QaW1jQ3pYdWdSVzBZRzgzUThDM0VxLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9emlXMHB5a3hvM2F0RFh3UEpPUGltY0N6WHVnUlcwWUc4M1E4QzNFcSxwPXpHbGFrS05TV0pLODU4TjkrQmNZU1V3WEVqYWNkNVEya01yb0FvaEp0b009</response>

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

2019-12-03 18:55:42 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:42 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:42 | [Mutex] received everything.

2019-12-03 18:55:42 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:42 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IaHF4cG1valRuV241RHF1SjlSSVZ2ekN2cENuc0N3S2FnUXJBRUFqLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SGhxeHBtb2pUblduNURxdUo5UklWdnpDdnBDbnNDd0thZ1FyQUVBaixwPXBnVVJENjM4WXdTSXcrSDNKWlVvTkNSWlVZL3hqQmQrekZKL2FGazNCeGs9</response>

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

2019-12-03 18:55:42 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:42 | [Mutex] received everything.

2019-12-03 18:55:42 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:42 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vSUNzTldVazBJQ0tIWXltMUE1RWd2dDB2SmsyTWNPZEZMY0RqRHBPLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b0lDc05XVWswSUNLSFl5bTFBNUVndnQwdkprMk1jT2RGTGNEakRwTyxwPW1ZRi81Y2VBZFpEbWdkaTc2NC9Tb2lkQ1V0U05tSWwwTkJKdEdLaUlTcG89</response>

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

2019-12-03 18:55:42 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:42 | [Mutex] received everything.

2019-12-03 18:55:42 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:42 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jaHdpZk1YWEs5ZTZRZGJKOTlzdVZiaEREZEJQMllTbWV4Z0pyanN4LHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y2h3aWZNWFhLOWU2UWRiSjk5c3VWYmhERGRCUDJZU21leGdKcmpzeCxwPUJydDhNZS9PWGdPZGtib0FENGFZLzhLL1gwR3pOSzJaNTZVdEpzNjFGeHc9</response>

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

2019-12-03 18:55:42 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:42 | [Mutex] received everything.

2019-12-03 18:55:42 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:42 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14RlNreGZRRGM4ZFJBSE90VjZaejZudnBoZWhTZ0xKTWFxWlM2cWZjLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eEZTa3hmUURjOGRSQUhPdFY2Wno2bnZwaGVoU2dMSk1hcVpTNnFmYyxwPWtqdGpWNEh3YWdKL1FZTnppUU1rZmtJZG5rU1h6RFNQTGhWdkgrajRySUk9</response>

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

2019-12-03 18:55:42 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:42 | [Mutex] received everything.

2019-12-03 18:55:42 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:42 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10YnIwak1NNGhaYmNza1hBc0liZHpESFlhZ3JKZ2dOdFIyY2xreHg0LHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dGJyMGpNTTRoWmJjc2tYQXNJYmR6REhZYWdySmdnTnRSMmNsa3h4NCxwPTNSbWsxTFVUVzRSZElWTVdZc05VWEZKZzZiNDFLMHNqeWRBK05lT0hJWE09</response>

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

2019-12-03 18:55:42 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:42 | [Mutex] received everything.

2019-12-03 18:55:42 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:42 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04TEpRcVdRSkM5MGZDTkY3M2xhYU5Ba2NibWU3UTdHVjVIVk1mSlJpLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OExKUXFXUUpDOTBmQ05GNzNsYWFOQWtjYm1lN1E3R1Y1SFZNZkpSaSxwPVUvWWFyOGkzR3FKM29WSUdxUHZnSElsbm5KSTJBVWs0VUVNSDNnR1VSeHc9</response>

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

2019-12-03 18:55:42 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:42 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:42 | [Mutex] received everything.

2019-12-03 18:55:42 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:42 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qN3BYekZOV3VTVzBIZ1o4cUhIQ1V2eEZDTU40bG5LOGdBM3ZidWhqLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:42 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ajdwWHpGTld1U1cwSGdaOHFISENVdnhGQ01ONGxuSzhnQTN2YnVoaixwPTNLYjZodDlpenRkQUJNWVVLM3hMdlpMcVZVMVY1R2RHUmlaODRodmh2K2s9</response>

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

2019-12-03 18:55:43 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:43 | [Mutex] received everything.

2019-12-03 18:55:43 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:43 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wSXBCMHZYTnVuRHNxbzBqUVhVSDFIb1ZPMTN4ZzZMd2dBMFdRT0d0LHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cElwQjB2WE51bkRzcW8walFYVUgxSG9WTzEzeGc2THdnQTBXUU9HdCxwPTU2cnpZQVlIZ0lWbEVjeGg1emJIdTdHQjhJNytqeU8xNjFEcGdPMmJMdU09</response>

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

2019-12-03 18:55:43 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:43 | [Mutex] received everything.

2019-12-03 18:55:43 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:43 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xVlRGWWRRaVZZdlN4Vkt2WXdtdWhPRmRsTjFCTFRnVGdpY0V5b0t1LHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MVZURllkUWlWWXZTeFZLdll3bXVoT0ZkbE4xQkxUZ1RnaWNFeW9LdSxwPUtTK0Nmbm5sOFRvRklpRnZ6Q0lDNUFVZHZVbXJIUldEZDhrWTBkMjBRckU9</response>

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

2019-12-03 18:55:43 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:43 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:43 | [Mutex] received everything.

2019-12-03 18:55:43 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:43 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PeGFrOG50QTZqMGd1TUZpdTl6U21lT1R6WWhUNWdSSk1hRW5qWUhwLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T3hhazhudEE2ajBndU1GaXU5elNtZU9UelloVDVnUkpNYUVuallIcCxwPTJGOW00MWRkZXJCUXVvdGpKSFJKd0hzR2lxWVhSc0V5MmlveExSUkRpaTg9</response>

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

2019-12-03 18:55:43 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:43 | [Mutex] received everything.

2019-12-03 18:55:43 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:43 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10VzVwSXpCSlJRUGJpZ1RJMHh3N0VSZjR6anY4bTZmbHE4eFAyN0d4LHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFc1cEl6QkpSUVBiaWdUSTB4dzdFUmY0emp2OG02ZmxxOHhQMjdHeCxwPW5tbHNUK3RNeUFrcWJjU0Vkc3VpSVhobzBsNlpJK3MwVWVVclh2R3VxTEU9</response>

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

2019-12-03 18:55:43 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:43 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:43 | [Mutex] received everything.

2019-12-03 18:55:43 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:43 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FWG9tek1uQ0pNb1h6SEYxUFNsWEZzbXJSZW5BaGFqeWViSlFYbUVuLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RVhvbXpNbkNKTW9YekhGMVBTbFhGc21yUmVuQWhhanllYkpRWG1FbixwPWN4ek45YUVUTmVZbmNIYjQ3b1BtN3NqM2RLYW5uZjJvS1NUTCt2RG5rbFk9</response>

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

2019-12-03 18:55:43 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:43 | [Mutex] received everything.

2019-12-03 18:55:43 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:43 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sRjJvSnE3c3FxVUx5RFIxVFhtTllnMXlkQ1pKNUJ4OW1OcUl4eHFBLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bEYyb0pxN3NxcVVMeURSMVRYbU5ZZzF5ZENaSjVCeDltTnFJeHhxQSxwPXI0UEJHY2Iya2JROGhJM1I4bnJYdTZMU2hWNGNkQmg5dzJXV2w4V0prNDA9</response>

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

2019-12-03 18:55:43 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:43 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:43 | [Mutex] received everything.

2019-12-03 18:55:43 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:43 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05TkJHekRZeFZPYkNNbUR2Q1ZEM2JZRFhDS1Y4TWVuak9wcDU3cU5FLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:43 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OU5CR3pEWXhWT2JDTW1EdkNWRDNiWURYQ0tWOE1lbmpPcHA1N3FORSxwPXFFNDVabFlCdUdlVkVPTDNTNjNQNSsyUjRwaWNLaEtqdTRiZFZ2T3Z6UG89</response>

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

2019-12-03 18:55:43 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:43 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:43 | [Mutex] received everything.

2019-12-03 18:55:43 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-12-03 18:55:44 | user :: user_wy56vt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01SmZVRHBvbHREZHRJbmczMmpQQkp5WHhFczlwbjl5aXYzWHp6OUlHLHM9eHJ6ME15dVJiSHpKSXc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:44 | user :: user_wy56vt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NUpmVURwb2x0RGR0SW5nMzJqUEJKeVh4RXM5cG45eWl2M1h6ejlJRyxwPUNERDZBeW10bS9QQWs3ZzJTS3NKWDBQNmZyVEtwdDFrVWNUUkptTVFaQnM9</response>

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

2019-12-03 18:55:46 | [Mutex] waiting for: [user]

2019-12-03 18:55:46 | [Mutex] received everything.

2019-12-03 18:55:46 | [Mutex] isItemNotified: user:ok:false :: true

2019-12-03 18:55:46 |

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

2019-12-03 18:55:46 | ------------------------------------

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4d098b92

2019-12-03 18:55:46 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@49cbbe22}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@43ce7c43}, 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@47f1e0e2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2f37678}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3a728af}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:46 PST 2019}}}}

2019-12-03 18:55:46 | [Mutex] waiting for: [registration]

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@333b70fc

2019-12-03 18:55:46 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@43ce7c43}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@47f1e0e2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2f37678}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3a728af}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:46 PST 2019}}}}

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@7b857089

2019-12-03 18:55:46 | 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-12-03 18:55:46 | 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-12-03 18:55:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@62dc8937}

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

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

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@58843793

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@30d000ef

2019-12-03 18:55:46 | 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-12-03 18:55:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@60813f44}

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

2019-12-03 18:55:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2c25b78d}

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

2019-12-03 18:55:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@66929752}

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1f531cbc

2019-12-03 18:55:46 | user :: null >> <iq to="localhost" id="UUHnUezlIziUYn3tapQax8L" type="set"><query xmlns="jabber:iq:register"><username>user_1k4wnx0028</username><password>user_1k4wnx0028</password><email>606106b4-4dc1-4093-aaef-fb6b07fa1b84@localhost</email></query></iq>

2019-12-03 18:55:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8e4b0dfb}

2019-12-03 18:55:46 | user :: null << <iq type="result" id="UUHnUezlIziUYn3tapQax8L" from="localhost" xmlns="jabber:client"/>

2019-12-03 18:55:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2f34b0c1}

2019-12-03 18:55:46 | [Mutex] received everything.

2019-12-03 18:55:46 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-03 18:55:46 | 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;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@62dc8937, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@60813f44]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@43ce7c43}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@47f1e0e2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2f37678}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3a728af}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:46 PST 2019}}}}

2019-12-03 18:55:46 | 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;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@62dc8937, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@60813f44]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@43ce7c43}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@47f1e0e2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2f37678}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3a728af}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:46 PST 2019}}}}

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4626c17c

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@347cf6ed

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@334daa22

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@39f5a632

2019-12-03 18:55:46 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4928ad51

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

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

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QeFR4UzQ0VGdkS0RsZzc0N0tzanpRdVZveE8zZWVOVXZPd2FJc3laLHM9TXJEa2NWVThXS25ZOVE9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UHhUeFM0NFRnZEtEbGc3NDdLc2p6UXVWb3hPM2VlTlV2T3dhSXN5WixwPTNIS1lVUWVxTjRNYUlrQ1pZYm8zSHR2aW0vMENXeS91K0czMU4yb0hlWEk9</response>

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj13aDNoUUJLOTVGL2FyRGk0Ty9qNzBvV1JnMHRMeXFjaDBDSC96bGhjWlJJPQ==</success>

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

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost >> <iq xmlns="jabber:client" id="4RwnY14CrWnLEzbxbPGAazv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost << <iq type="result" id="4RwnY14CrWnLEzbxbPGAazv" to="user_1k4wnx0028@localhost/993927746-tigase-20" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_1k4wnx0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="yJ6BvnY14CrWnLEzbxbPGAa" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost/993927746-tigase-20 << <iq type="result" id="yJ6BvnY14CrWnLEzbxbPGAa" to="user_1k4wnx0028@localhost/993927746-tigase-20" xmlns="jabber:client"/>

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="7FSKY9mdr0hBnRbo00fRJCE" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost/993927746-tigase-20 << <enabled id="08f6bdf4-a6bd-46c4-8c0d-01d65bd7b977" max="60" resume="true" xmlns="urn:xmpp:sm:3" location="d4270859fb27"/>

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost/993927746-tigase-20 >> <iq id="1VCm9BzmNCIDk9jKLzjJVSY" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost/993927746-tigase-20 << <iq type="result" id="7FSKY9mdr0hBnRbo00fRJCE" from="localhost" to="user_1k4wnx0028@localhost/993927746-tigase-20" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-12-03 18:55:46 | user :: user_1k4wnx0028@localhost/993927746-tigase-20 << <iq type="result" id="1VCm9BzmNCIDk9jKLzjJVSY" to="user_1k4wnx0028@localhost/993927746-tigase-20" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 18:55:46 | Disconnecting

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

2019-12-03 18:55:46 | [Mutex] notify: [disconnected]

2019-12-03 18:55:46 | [Mutex] received everything.

2019-12-03 18:55:46 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:47 | user :: user_1k4wnx0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kTmh2RFV1MTVEaXB1Zms1U1E3aXVaMUZqNnczeHh2WnZON0gybHh6LHM9TXJEa2NWVThXS25ZOVE9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:47 | user :: user_1k4wnx0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZE5odkRVdTE1RGlwdWZrNVNRN2l1WjFGajZ3M3h4dlp2TjdIMmx4eixwPUhYalhmMGtaTjdOc0xRR3ZSdis2RGpZWEpWalIyUUYyQUVXOHZxWnRPaUk9</response>

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

2019-12-03 18:55:47 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:47 | [Mutex] received everything.

2019-12-03 18:55:47 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:47 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:47 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:47 | user :: user_1k4wnx0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pU2dBVFJRU3hVdG44b1RpUGpZNFdOUXUyazdkNVhXVGpCTHVIY2JKLHM9TXJEa2NWVThXS25ZOVE9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:47 | user :: user_1k4wnx0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aVNnQVRSUVN4VXRuOG9UaVBqWTRXTlF1Mms3ZDVYV1RqQkx1SGNiSixwPVcwQTJQc016eURmazBjY2xlMGJVQzA1SWQzV08rUHBFZGJBeG04Y2pPMlk9</response>

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

2019-12-03 18:55:47 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:47 | [Mutex] received everything.

2019-12-03 18:55:47 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:47 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:47 | user :: user_1k4wnx0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EeDRiUmlDZjZFTUVTYkN4d0hkWnlidkhTSEdYeVhpcGtLbTlhWE9OLHM9TXJEa2NWVThXS25ZOVE9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:47 | user :: user_1k4wnx0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RHg0YlJpQ2Y2RU1FU2JDeHdIZFp5YnZIU0hHWHlYaXBrS205YVhPTixwPVBhU0I0T1Rla1N4WXF4cC9DUy92V2pRU01ZVWJ1eVZVM1czaE0yRHBuUGc9</response>

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

2019-12-03 18:55:47 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:47 | [Mutex] received everything.

2019-12-03 18:55:47 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:47 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:47 | user :: user_1k4wnx0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wRWVrRXhWYldrSXhKWFZNTnR6RUY1MzE2Y1pXeEswVGYxMllrb1FaLHM9TXJEa2NWVThXS25ZOVE9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:47 | user :: user_1k4wnx0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MEVla0V4VmJXa0l4SlhWTU50ekVGNTMxNmNaV3hLMFRmMTJZa29RWixwPTFWZ3IydWV0aUdJYk44VDd2NU5EekhSdmZaUmUxWWJFYVNpMDdpcVpqQmc9</response>

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

2019-12-03 18:55:47 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:47 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:47 | [Mutex] received everything.

2019-12-03 18:55:47 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-12-03 18:55:47 | user :: user_1k4wnx0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BcWVHUlZaU0xSZ05Bcm1IWTdtUUhveHFKaXJsajJvWmM4cjBLeDhSLHM9TXJEa2NWVThXS25ZOVE9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:47 | user :: user_1k4wnx0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QXFlR1JWWlNMUmdOQXJtSFk3bVFIb3hxSmlybGoyb1pjOHIwS3g4UixwPW5LUi9mYW1RN2FrbjhrY1hWSWdjZDlqbjFrRUF5bUtJZzE0YVdMZXBoc1E9</response>

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

2019-12-03 18:55:49 | [Mutex] waiting for: [user]

2019-12-03 18:55:49 | [Mutex] received everything.

2019-12-03 18:55:49 | [Mutex] isItemNotified: user:ok:true :: true

2019-12-03 18:55:49 |

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

2019-12-03 18:55:49 | ------------------------------------

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6be8932a

2019-12-03 18:55:49 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@49cbbe22}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@652f7027}, 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@6110f85a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@24127a1c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@bcccc77}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:49 PST 2019}}}}

2019-12-03 18:55:49 | [Mutex] waiting for: [registration]

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@157c3b61

2019-12-03 18:55:49 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@652f7027}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@6110f85a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@24127a1c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@bcccc77}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:49 PST 2019}}}}

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@7348d3bc

2019-12-03 18:55:49 | 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-12-03 18:55:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@443d8553}

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

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

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@297f46d7

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5dacd7aa

2019-12-03 18:55:49 | 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-12-03 18:55:49 | 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-12-03 18:55:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@684c3a90}

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

2019-12-03 18:55:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d11c4f91}

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

2019-12-03 18:55:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@40733dd7}

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@13e982f0

2019-12-03 18:55:49 | user :: null >> <iq to="localhost" id="OM3x6qQVdr2u5nMHyq0rbJG" type="set"><query xmlns="jabber:iq:register"><username>user_vu3rbq0029</username><password>user_vu3rbq0029</password><email>264c9559-8f55-4ed8-a67f-82f872bc706d@localhost</email></query></iq>

2019-12-03 18:55:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a1f84f88}

2019-12-03 18:55:49 | [Mutex] received everything.

2019-12-03 18:55:49 | user :: null << <iq type="result" id="OM3x6qQVdr2u5nMHyq0rbJG" from="localhost" xmlns="jabber:client"/>

2019-12-03 18:55:49 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-03 18:55:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@28c306a0}

2019-12-03 18:55:49 | 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;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@443d8553, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@684c3a90]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@652f7027}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@6110f85a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@24127a1c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@bcccc77}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:49 PST 2019}}}}

2019-12-03 18:55:49 | 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;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@443d8553, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@684c3a90]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@652f7027}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@6110f85a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@24127a1c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@bcccc77}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:49 PST 2019}}}}

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@21523192

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@78163dea

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2737ce1a

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@17712a5a

2019-12-03 18:55:49 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@279f5787

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

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

2019-12-03 18:55:49 | user :: user_vu3rbq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qSE5UOWFja0dqSk1mV2tFNWJnUU04czU4V3EzYkduVFdub0ZBMlBmLHM9Z3AvaTBFM3lPOFlVc1E9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:49 | user :: user_vu3rbq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9akhOVDlhY2tHakpNZldrRTViZ1FNOHM1OFdxM2JHblRXbm9GQTJQZixwPWJUQVV6ZmxyLzlRanh6SFkyRWZEcDlVbjE1QnpsWGVmVEx0NGU1NmIzYkE9</response>

2019-12-03 18:55:49 | user :: user_vu3rbq0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ncGMvbUJURUx0dVZBRWJYdk9zbFI0OXpsT2lFMmtaaHpXNGdIVWQ1Yk9ZPQ==</success>

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

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost >> <iq xmlns="jabber:client" id="ZTmIziUYn3tapQax8LxcFnV" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost << <iq type="result" id="ZTmIziUYn3tapQax8LxcFnV" to="user_vu3rbq0029@localhost/993927746-tigase-21" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_vu3rbq0029@localhost/993927746-tigase-21</jid></bind></iq>

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

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost/993927746-tigase-21 << <iq type="result" id="Icft4pRTTfwgwhVRSar5cxe" to="user_vu3rbq0029@localhost/993927746-tigase-21" xmlns="jabber:client"/>

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="ySfT5xiFmcBg13eJvbtpQUO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost/993927746-tigase-21 << <enabled id="97c28a77-1789-40f8-afef-fcc7a367e080" max="60" resume="true" xmlns="urn:xmpp:sm:3" location="d4270859fb27"/>

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost/993927746-tigase-21 >> <iq id="f0BdBj5cCeHLxeSRVSTWcyx" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost/993927746-tigase-21 << <iq type="result" id="ySfT5xiFmcBg13eJvbtpQUO" from="localhost" to="user_vu3rbq0029@localhost/993927746-tigase-21" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost/993927746-tigase-21 << <iq type="result" id="f0BdBj5cCeHLxeSRVSTWcyx" to="user_vu3rbq0029@localhost/993927746-tigase-21" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 18:55:50 | Disconnecting

2019-12-03 18:55:50 | [Mutex] notify: [disconnected]

2019-12-03 18:55:50 | [Mutex] received everything.

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

2019-12-03 18:55:50 | [Mutex] waiting for: [event]

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

2019-12-03 18:55:50 | user :: user_vu3rbq0029@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-12-03 18:55:50 | user :: user_vu3rbq0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfdnUzcmJxMDAyOQAgLSAtIC0gLSAt</auth>

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

2019-12-03 18:55:50 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:50 | [Mutex] received everything.

2019-12-03 18:55:50 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:50 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:50 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CRjZDNDR2Q3ZKT0R1alJTNlp3NkptNjVWMFVYVEZ5cnRaM0t6cm4zLHM9Z3AvaTBFM3lPOFlVc1E9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QkY2QzQ0dkN2Sk9EdWpSUzZadzZKbTY1VjBVWFRGeXJ0WjNLenJuMyxwPXVWRWMrc1hjYjMyUThPWksrTE5jUnR3d3M3LzUxeEhLUUJwcS90dzcwbnM9</response>

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

2019-12-03 18:55:50 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:50 | [Mutex] notify: [event, disconnected]

2019-12-03 18:55:50 | [Mutex] received everything.

2019-12-03 18:55:50 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:50 | [Mutex] waiting for: [event]

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

2019-12-03 18:55:50 | user :: user_vu3rbq0029@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-12-03 18:55:50 | user :: user_vu3rbq0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3Z1M3JicTAwMjkscj1sZVpma0U5REU5clVJWk40QkVkRQ==</auth>

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sZVpma0U5REU5clVJWk40QkVkRVlvWURxUWswMWJXTUVmNnJqaHFYLHM9cDFnNFpHaHp1SVduWmc9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bGVaZmtFOURFOXJVSVpONEJFZEVZb1lEcVFrMDFiV01FZjZyamhxWCxwPXdjbzZ2dGZWNzFRUEpJYzY4Ym8rSEpkT1lEND0=</response>

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

2019-12-03 18:55:50 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:50 | [Mutex] received everything.

2019-12-03 18:55:50 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:50 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TQjB4YmNMMWZwWTVRWHpQeXRWdmxVVXVYNzJVWnpacmFUWEw2N3NILHM9Z3AvaTBFM3lPOFlVc1E9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U0IweGJjTDFmcFk1UVh6UHl0VnZsVVV1WDcyVVp6WnJhVFhMNjdzSCxwPTg2N2RXYVp6WSsrLzZkMW0vZkZDd2tRYVE4UCtyWDMrTnU2TGtFd040Snc9</response>

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

2019-12-03 18:55:50 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:50 | [Mutex] received everything.

2019-12-03 18:55:50 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qQk42V25keUs1RklsZEhEZHFiWGRoUDlBOURSMkZNQ0Y0WmQzNDF1LHM9Z3AvaTBFM3lPOFlVc1E9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:50 | user :: user_vu3rbq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9akJONlduZHlLNUZJbGRIRGRxYlhkaFA5QTlEUjJGTUNGNFpkMzQxdSxwPXhCRXg2WXVYTGlDVE10SDRobytndXpmQWxRMFE3TVgxSkhwSXM5bC9iR3c9</response>

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

2019-12-03 18:55:52 | [Mutex] waiting for: [user]

2019-12-03 18:55:52 | [Mutex] received everything.

2019-12-03 18:55:52 | [Mutex] isItemNotified: user:ok:true :: true

2019-12-03 18:55:52 |

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

2019-12-03 18:55:52 | ------------------------------------

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4068bdf4

2019-12-03 18:55:52 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@49cbbe22}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4eaf5b89}, 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@4a90d684}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@f9251b2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@a90caa9}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:52 PST 2019}}}}

2019-12-03 18:55:52 | [Mutex] waiting for: [registration]

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3ed7bb61

2019-12-03 18:55:52 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4eaf5b89}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@4a90d684}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@f9251b2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@a90caa9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:52 PST 2019}}}}

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@723f7ec9

2019-12-03 18:55:52 | 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-12-03 18:55:52 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6fbdaefd}

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

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

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@6374f421

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@607b579d

2019-12-03 18:55:52 | 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-12-03 18:55:52 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@693bb46d}

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

2019-12-03 18:55:52 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8758d76c}

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

2019-12-03 18:55:52 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6bf335f1}

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@2f621152

2019-12-03 18:55:52 | user :: null >> <iq to="localhost" id="n2ztX4ydDiJCygXdNOHqkRM" type="set"><query xmlns="jabber:iq:register"><username>user_gzk0yp0030</username><password>user_gzk0yp0030</password><email>78816d64-3f4d-4e69-a1b8-8730e9675994@localhost</email></query></iq>

2019-12-03 18:55:52 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@33cca6ea}

2019-12-03 18:55:52 | user :: null << <iq type="result" id="n2ztX4ydDiJCygXdNOHqkRM" from="localhost" xmlns="jabber:client"/>

2019-12-03 18:55:52 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@159f6c9c}

2019-12-03 18:55:52 | [Mutex] received everything.

2019-12-03 18:55:52 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-03 18:55:52 | 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;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6fbdaefd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@693bb46d]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4eaf5b89}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@4a90d684}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@f9251b2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@a90caa9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:52 PST 2019}}}}

2019-12-03 18:55:52 | 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;@49cbbe22}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6fbdaefd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@693bb46d]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4eaf5b89}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@8f6b419}, 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@4a90d684}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@f9251b2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@a90caa9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Dec 03 18:55:52 PST 2019}}}}

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@21b32a9e

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@531ddfe4

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6ccabc54

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2dfc6dd

2019-12-03 18:55:52 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3a00ebc2

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

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

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KQzNvT1ZBQWZTU3pRQlhKYmRKWkJwNTN0NWJScjVHam1Hd2FzS0hsLHM9TlB5S0t2VmRodTZPN0E9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SkMzb09WQUFmU1N6UUJYSmJkSlpCcDUzdDViUnI1R2ptR3dhc0tIbCxwPXdYRXR5MHcxVW9rL2duVVE1aW9WUXdCb1daTG5oUzY3QitmeEZuTThUdU09</response>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1pY2tpeDRBcHphMkFEMW1kYmhpb0F2eUhnQ3hWWTBpM1NqSlBaVllxTTNJPQ==</success>

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

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost >> <iq xmlns="jabber:client" id="A7MT05cSXYrTU5dBj5cCeHL" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost << <iq type="result" id="A7MT05cSXYrTU5dBj5cCeHL" to="user_gzk0yp0030@localhost/993927746-tigase-22" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_gzk0yp0030@localhost/993927746-tigase-22</jid></bind></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="iWdRKIq5x5k4fHqZ8Ak5tjQ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-22 << <iq type="result" id="iWdRKIq5x5k4fHqZ8Ak5tjQ" to="user_gzk0yp0030@localhost/993927746-tigase-22" xmlns="jabber:client"/>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="t3w2dAu8HHLKzaOPIVRQXX5" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-22 >> <iq id="R5A8vnLGMFx6lQ0aLP1gBeW" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-22 << <enabled id="93be6d4a-2690-406c-8279-67727ca577fa" max="60" resume="true" xmlns="urn:xmpp:sm:3" location="d4270859fb27"/>

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

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-22 << <iq type="result" id="t3w2dAu8HHLKzaOPIVRQXX5" from="localhost" to="user_gzk0yp0030@localhost/993927746-tigase-22" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-22 << <iq type="result" id="R5A8vnLGMFx6lQ0aLP1gBeW" to="user_gzk0yp0030@localhost/993927746-tigase-22" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 18:55:53 | Disconnecting

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

2019-12-03 18:55:53 | [Mutex] notify: [disconnected]

2019-12-03 18:55:53 | [Mutex] received everything.

2019-12-03 18:55:53 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zUVBGSjlnZkVZcEJsdEJWYWJNSnBlYVpiWUgxaHlHZnVsYUNrRFZQLHM9TlB5S0t2VmRodTZPN0E9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c1FQRko5Z2ZFWXBCbHRCVmFiTUpwZWFaYllIMWh5R2Z1bGFDa0RWUCxwPWdSczJQc05OSUdnVEQ2M0RoRVVBWUQvNDdlbng3NnQ5MEdJeExCNkpkaHc9</response>

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

2019-12-03 18:55:53 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:53 | [Mutex] received everything.

2019-12-03 18:55:53 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:53 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14a2xRMTZiT2dTc1gxRERNaUlYREZxS0ZUTGtsREluN2p3MzRTRDJOLHM9TlB5S0t2VmRodTZPN0E9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eGtsUTE2Yk9nU3NYMURETWlJWERGcUtGVExrbERJbjdqdzM0U0QyTixwPWYycmhJcFZhL0puQ3o3bEhVWSs5ajlnRkFYSWNpMGJFUmZpdkh3aVpTN2M9</response>

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

2019-12-03 18:55:53 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:53 | [Mutex] received everything.

2019-12-03 18:55:53 | [Mutex] isItemNotified: authFailed :: true

2019-12-03 18:55:53 | [Mutex] waiting for: [event]

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

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

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sbm5TVEpYUW9OZTRkZ1c5cVRvQkRVZ1l6Mjc1V3FqblFCTUg4eVNvLHM9TlB5S0t2VmRodTZPN0E9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bG5uU1RKWFFvTmU0ZGdXOXFUb0JEVWdZejI3NVdxam5RQk1IOHlTbyxwPStXT21JdVYzZjF5MStQOUd2NlFFWDhaTmV6M3l6U05ENEwzcGlGd1IvVkE9</response>

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

2019-12-03 18:55:53 | [Mutex] notify: [event, authFailed]

2019-12-03 18:55:53 | [Mutex] received everything.

2019-12-03 18:55:53 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QekVFZzVUUWdkWkZseTN2U05hOEY1WDJnVWlTY0FWeThsU1VpN2NZLHM9TlB5S0t2VmRodTZPN0E9PSxpPTQwOTY=</challenge>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UHpFRWc1VFFnZFpGbHkzdlNOYThGNVgyZ1VpU2NBVnk4bFNVaTdjWSxwPXROdWtPMTBGeHVUZ3FKZThEd2tQRXQvblF1WlFyREVURWNoYit3bXF3MFU9</response>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1JakJoVlJSdWpmbWN4aFgyLy9jMGhRMnJvNllaNFBzK3pIQXNCaFBJWEZjPQ==</success>

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

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost >> <iq xmlns="jabber:client" id="n7EDhIQNNCnU8qhR5oRKY9m" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost << <iq type="result" id="n7EDhIQNNCnU8qhR5oRKY9m" to="user_gzk0yp0030@localhost/993927746-tigase-23" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_gzk0yp0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="zkfLT05cSXYrTU5dBj5cCeH" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-23 << <iq type="result" id="zkfLT05cSXYrTU5dBj5cCeH" to="user_gzk0yp0030@localhost/993927746-tigase-23" xmlns="jabber:client"/>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="C8DjEMLAFlOTPPLZ0es9FlQ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-23 << <enabled id="2cb92a15-8086-491a-bb5e-e20e3bd06d63" max="60" resume="true" xmlns="urn:xmpp:sm:3" location="d4270859fb27"/>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-23 >> <iq id="3mhP1gBeW5eXVYdt7l9kSKJ" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-23 << <iq type="result" id="C8DjEMLAFlOTPPLZ0es9FlQ" from="localhost" to="user_gzk0yp0030@localhost/993927746-tigase-23" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10592/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-12-03 18:55:53 | user :: user_gzk0yp0030@localhost/993927746-tigase-23 << <iq type="result" id="3mhP1gBeW5eXVYdt7l9kSKJ" to="user_gzk0yp0030@localhost/993927746-tigase-23" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-12-03 18:55:53 | Disconnecting

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

2019-12-03 18:55:53 | [Mutex] notify: [disconnected]

2019-12-03 18:55:53 | [Mutex] received everything.

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

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

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