Brute Force Prevention

2019-11-25 19:13:05 |

2019-11-25 19:13:05 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 19:13:05 | ------------------------------------

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@746da323

2019-11-25 19:13:05 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7aaa43de}, 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@7e95c853}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b9749e5}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@227a810f}, 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=Mon Nov 25 19:13:05 PST 2019}}}}

2019-11-25 19:13:05 | [Mutex] waiting for: [registration]

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@ae6922d

2019-11-25 19:13:05 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7aaa43de}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@7e95c853}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b9749e5}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@227a810f}, 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=Mon Nov 25 19:13:05 PST 2019}}}}

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@5ae10472

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

2019-11-25 19:13:05 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5bb8b6aa}

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

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

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

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2dbc262b

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1375be4b

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

2019-11-25 19:13:05 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@41e5eac3}

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

2019-11-25 19:13:05 | user :: null >> <iq to="localhost" id="QSTdVT1eArn5iWWbP5t4zbH" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 19:13:05 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c408b162}

2019-11-25 19:13:05 | user :: null << <iq type="result" id="QSTdVT1eArn5iWWbP5t4zbH" 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-11-25 19:13:05 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5ff609b3}

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1337f118

2019-11-25 19:13:05 | user :: null >> <iq to="localhost" id="rGh1nS6gP7FDodthX08AncB" type="set"><query xmlns="jabber:iq:register"><username>user_o6yhzz0027</username><password>user_o6yhzz0027</password><email>eb4b1610-dd73-4ce1-91ab-ba4fa28cac10@localhost</email></query></iq>

2019-11-25 19:13:05 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c796e93f}

2019-11-25 19:13:05 | user :: null << <iq type="result" id="rGh1nS6gP7FDodthX08AncB" from="localhost" xmlns="jabber:client"/>

2019-11-25 19:13:05 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2d0e92d3}

2019-11-25 19:13:05 | [Mutex] received everything.

2019-11-25 19:13:05 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 19:13:05 | 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;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5bb8b6aa, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@41e5eac3]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7aaa43de}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@7e95c853}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b9749e5}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@227a810f}, 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=Mon Nov 25 19:13:05 PST 2019}}}}

2019-11-25 19:13:05 | 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;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5bb8b6aa, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@41e5eac3]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7aaa43de}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@7e95c853}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b9749e5}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@227a810f}, 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=Mon Nov 25 19:13:05 PST 2019}}}}

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@43d3c643

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2c87f41b

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@947fa2

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@59d5fd69

2019-11-25 19:13:05 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@469c9ce

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

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1CenB1a3kwdk4wWENWVm1vV3hxYw==</auth>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CenB1a3kwdk4wWENWVm1vV3hxY0tDRGZXT3dwczI0ZUhmNHNVdXA0LHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QnpwdWt5MHZOMFhDVlZtb1d4cWNLQ0RmV093cHMyNGVIZjRzVXVwNCxwPUh4ZFYybFd5TVNOUEluS0hKcG9ZMjNOMi9GUXhNNXdwUDIxaDRITEdkNjA9</response>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1Xb0MzOUNWNy9mTnJVZzRYQStmNFVseWhnNXpGMDBVKzZ1YXRTUEowK3JrPQ==</success>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost >> <iq xmlns="jabber:client" id="pC3cFPZ6yaDJT5i15vpUWcB" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost << <iq to="user_o6yhzz0027@localhost/993927746-tigase-19" type="result" id="pC3cFPZ6yaDJT5i15vpUWcB" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_o6yhzz0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="yUTbFslJNZ4gQTeFqQUTgZt" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost/993927746-tigase-19 << <iq to="user_o6yhzz0027@localhost/993927746-tigase-19" type="result" id="yUTbFslJNZ4gQTeFqQUTgZt" xmlns="jabber:client"/>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="bAT4l8t24mN4BHr7qYdVbuk" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost/993927746-tigase-19 << <enabled max="60" resume="true" id="f8bd05d1-4af4-43ca-a54c-cecb51f5bbbb" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost/993927746-tigase-19 >> <iq id="gzOAoRcRdtbyeJXfCAeLZp7" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost/993927746-tigase-19 << <iq to="user_o6yhzz0027@localhost/993927746-tigase-19" type="result" id="gzOAoRcRdtbyeJXfCAeLZp7" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:13:05 | Disconnecting

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

2019-11-25 19:13:05 | [Mutex] notify: [disconnected]

2019-11-25 19:13:05 | [Mutex] received everything.

2019-11-25 19:13:05 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:05 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1IS3o0enczYXMwd3IzRTBQdHR2Ug==</auth>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IS3o0enczYXMwd3IzRTBQdHR2UlBqckd2dGZEOXk2TmN5c2g1SjZBLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SEt6NHp3M2FzMHdyM0UwUHR0dlJQanJHdnRmRDl5Nk5jeXNoNUo2QSxwPUJpTHFzV1E5akxXdXZiNk56RmxwNGxJdHJMRVNWVEtOUlNYeU5vR3ZxMUU9</response>

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

2019-11-25 19:13:06 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:06 | [Mutex] received everything.

2019-11-25 19:13:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:06 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1hbTV2V0xhRmpyb0RKcVBLNDh3MA==</auth>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hbTV2V0xhRmpyb0RKcVBLNDh3MEEwNWZZbmh6UmtnREZZNE16NjcwLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YW01dldMYUZqcm9ESnFQSzQ4dzBBMDVmWW5oelJrZ0RGWTRNejY3MCxwPWozMm0vaDhOODduWlNiRk44V01SQ0ZqVTNvN1ByaEJIZEtwanlWNmJyUWc9</response>

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

2019-11-25 19:13:06 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:06 | [Mutex] received everything.

2019-11-25 19:13:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:06 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1ldE01T3NUZXhCWWhsZmdQQWNvUg==</auth>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ldE01T3NUZXhCWWhsZmdQQWNvUkozc2N0ZzduYUkzU0VJTmwyNGtkLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZXRNNU9zVGV4QllobGZnUEFjb1JKM3NjdGc3bmFJM1NFSU5sMjRrZCxwPXpGLzVPVGNFVnRobytUT01EYVNwM3RvbVpKNzBpNUt5NXFoYnAycWo0aE09</response>

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

2019-11-25 19:13:06 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:06 | [Mutex] received everything.

2019-11-25 19:13:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:06 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1vUHNOcWJUcmdpcTZLcUtPTVQ5OQ==</auth>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vUHNOcWJUcmdpcTZLcUtPTVQ5OThMdTlRR3pOM3NGc1FJTW0zanZ1LHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b1BzTnFiVHJnaXE2S3FLT01UOTk4THU5UUd6TjNzRnNRSU1tM2p2dSxwPTJoRmtLb1p0REJ5NFcxVEY2RGtGZ0lCVWxQYWgzK29OUEJoSWExbGowanc9</response>

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

2019-11-25 19:13:06 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:06 | [Mutex] received everything.

2019-11-25 19:13:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:06 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj04cm9CZXlsR3VjT0lVRnpBU1V6Nw==</auth>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04cm9CZXlsR3VjT0lVRnpBU1V6N05oenRHYjI1UEYxdHdLcjN3Vlp3LHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OHJvQmV5bEd1Y09JVUZ6QVNVejdOaHp0R2IyNVBGMXR3S3Izd1ZadyxwPVcycjlrK2hHSVB1N3lXQXBKeTRSelBxYkhtMnZzQVZoNndFZmc3cjhpT0U9</response>

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

2019-11-25 19:13:06 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:06 | [Mutex] received everything.

2019-11-25 19:13:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:06 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1vRWFQRHNtUDdLTEdEVW9rc2Uxbg==</auth>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vRWFQRHNtUDdLTEdEVW9rc2UxblFXMGxLYU5VWUN2cmVUUFlvc3gwLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b0VhUERzbVA3S0xHRFVva3NlMW5RVzBsS2FOVVlDdnJlVFBZb3N4MCxwPUlGeEFvNXVBeFZBVlM2MndZR05rRlBIOVdtS2dVUG1Pb2s4cmdrRWZDR1k9</response>

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

2019-11-25 19:13:06 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:06 | [Mutex] received everything.

2019-11-25 19:13:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:06 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1VZndvSjduT2U1VkhSUmFlZkR1Tg==</auth>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VZndvSjduT2U1VkhSUmFlZkR1TkJRb3VGeW50ZmZyNE95UUdGbG5RLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VWZ3b0o3bk9lNVZIUlJhZWZEdU5CUW91RnludGZmcjRPeVFHRmxuUSxwPXI4QzBkMmd1MWsycmxTU0lSN0IvM2NhM3RHNFVmek5GRkdHRW14TjFxTzA9</response>

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

2019-11-25 19:13:06 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:06 | [Mutex] received everything.

2019-11-25 19:13:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:06 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:06 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1ReHlHSlNqOG1QTzVsR3ZCM3NUaA==</auth>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ReHlHSlNqOG1QTzVsR3ZCM3NUaGRzR01rNDZoSzlNVzg2UHNkbksyLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UXh5R0pTajhtUE81bEd2QjNzVGhkc0dNazQ2aEs5TVc4NlBzZG5LMixwPXRxanJ0OUFPYnJkNkF4N09JTHVEcEhRc2ZGTVk3MUxsbXRSOThKbFh2d289</response>

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

2019-11-25 19:13:07 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:07 | [Mutex] received everything.

2019-11-25 19:13:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:07 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1qdFZUcHRJeENRYWtuMVBVR1hmRg==</auth>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qdFZUcHRJeENRYWtuMVBVR1hmRk1DTUdOVkFSTVBSNlFkUWxGazYyLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9anRWVHB0SXhDUWFrbjFQVUdYZkZNQ01HTlZBUk1QUjZRZFFsRms2MixwPTh1aUxtVXo4Q2Z5YnJSRG5OV0ZFaEFJc0paWTVMTis4VzV0NHBjRUlvdVk9</response>

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

2019-11-25 19:13:07 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:07 | [Mutex] received everything.

2019-11-25 19:13:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:07 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj11Y1UwNTdlOE9RZ3AxeUpPZU9weA==</auth>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11Y1UwNTdlOE9RZ3AxeUpPZU9weEI2Q1VMSTlCWkduM0czcUx2MWJOLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWNVMDU3ZThPUWdwMXlKT2VPcHhCNkNVTEk5QlpHbjNHM3FMdjFiTixwPXJMc0xqcFg5V2xobGQvdmpvNFFqd092TS9Qa1kzc0ptQlI3c3ZHb0ViWDg9</response>

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

2019-11-25 19:13:07 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:07 | [Mutex] received everything.

2019-11-25 19:13:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:07 | [Mutex] notify: [event, disconnected]

2019-11-25 19:13:07 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1PMVJJSVJ2Q1lGYklueVc0TkwzZQ==</auth>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PMVJJSVJ2Q1lGYklueVc0TkwzZVV3UzgxOGNtSUI2ZVZ0SWJIdGMwLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TzFSSUlSdkNZRmJJbnlXNE5MM2VVd1M4MThjbUlCNmVWdEliSHRjMCxwPXRKVnZiWXZwV3pCcGtHVjVGVUhYOEg5TWphNGk3L1BBdTdoTzJhem5Eazg9</response>

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

2019-11-25 19:13:07 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:07 | [Mutex] received everything.

2019-11-25 19:13:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:07 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1nZ05ldDZVQnJKZlFLVHNqQUhvZQ==</auth>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nZ05ldDZVQnJKZlFLVHNqQUhvZWY2TUpDWm1FUFpqUUlXZGZ0eGNnLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z2dOZXQ2VUJySmZRS1RzakFIb2VmNk1KQ1ptRVBaalFJV2RmdHhjZyxwPUpjNGRxWmxBUStrNU5JZ3dEajNDOVJiYm95TGQ5UWQwOEdkYjNIT0tmdWs9</response>

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

2019-11-25 19:13:07 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:07 | [Mutex] received everything.

2019-11-25 19:13:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:07 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1sYUpka1F5Qm1zaER4d3UzVDhEQw==</auth>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sYUpka1F5Qm1zaER4d3UzVDhEQ25uZzA3RzE1blN0RWhON1JXQ29iLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bGFKZGtReUJtc2hEeHd1M1Q4RENubmcwN0cxNW5TdEVoTjdSV0NvYixwPUtSUERRVUsvTHA5QVo4aWZiR2htdmFucEVheVJoUlV2VHo5QUo5QmFTYWc9</response>

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

2019-11-25 19:13:07 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:07 | [Mutex] received everything.

2019-11-25 19:13:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:07 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1BTEdJMzM1RU5KU3RhOFRXR3dHQw==</auth>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BTEdJMzM1RU5KU3RhOFRXR3dHQ0xuMEcwdXdTdDNQTmlXQWJrcjZSLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QUxHSTMzNUVOSlN0YThUV0d3R0NMbjBHMHV3U3QzUE5pV0Fia3I2UixwPWRSMHg3ZmRnZWRqMkQwU0ZLTXpSZ0hveVB3d2tpZHFPWnptSldiMVRxbk09</response>

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

2019-11-25 19:13:07 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:07 | [Mutex] received everything.

2019-11-25 19:13:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:07 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1yZUQzVG5yeU93dElnbVNtRWR6bw==</auth>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yZUQzVG5yeU93dElnbVNtRWR6bzRuRHExbW5HRk9mT2E3ejhSOGxOLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cmVEM1RucnlPd3RJZ21TbUVkem80bkRxMW1uR0ZPZk9hN3o4UjhsTixwPURqOVlvcDUrVmI1YjNZMytxWEVYZnpwYUJ2UDJjN3NqMTRIZjV5S3RuU0k9</response>

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

2019-11-25 19:13:07 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:07 | [Mutex] received everything.

2019-11-25 19:13:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:07 | [Mutex] notify: [event, disconnected]

2019-11-25 19:13:07 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj14RDR3azJNekdNOFRLeWZzOExKYw==</auth>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14RDR3azJNekdNOFRLeWZzOExKY0NWWVZJMW1wSWh6ZklHTzNHMklkLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:07 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eEQ0d2syTXpHTThUS3lmczhMSmNDVllWSTFtcEloemZJR08zRzJJZCxwPVE5UHFuOTlXOTdUbHRITm42OVEzb3NUWlJodW0rSm1aUy9MSjZEM25XOTg9</response>

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

2019-11-25 19:13:07 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:07 | [Mutex] received everything.

2019-11-25 19:13:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:08 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj10bEpqUDE2eWhvVVdFeTg5ZEVCTg==</auth>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10bEpqUDE2eWhvVVdFeTg5ZEVCTmhMMDVUWG1EbW9zelN5SFBHS1J5LHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dGxKalAxNnlob1VXRXk4OWRFQk5oTDA1VFhtRG1vc3pTeUhQR0tSeSxwPWJXSFdtK3poaEZpM3pkTXJjNURQSS8ycUNzQ053T2hUcXd4dTltVVU2dmc9</response>

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

2019-11-25 19:13:08 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:08 | [Mutex] received everything.

2019-11-25 19:13:08 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:08 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj0wT1ZuR0pCcW80VlpSZWFwcFlNVA==</auth>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wT1ZuR0pCcW80VlpSZWFwcFlNVDhFZDVJV0hqNjBUSFVNRUhtY3ZlLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ME9WbkdKQnFvNFZaUmVhcHBZTVQ4RWQ1SVdIajYwVEhVTUVIbWN2ZSxwPTVZS2s0ems1eVluMjYrQXlYQUJUVmpQVmI2NUVWYjRtR0VSdHk3RWtyeWM9</response>

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

2019-11-25 19:13:08 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:08 | [Mutex] notify: [event, disconnected]

2019-11-25 19:13:08 | [Mutex] received everything.

2019-11-25 19:13:08 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:08 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1CMU5YdWtiZ3ZmRkk2VjJDeDZhdw==</auth>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CMU5YdWtiZ3ZmRkk2VjJDeDZhd2Y1M0VQQVdLQ1J0STkycEYxZDdvLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QjFOWHVrYmd2ZkZJNlYyQ3g2YXdmNTNFUEFXS0NSdEk5MnBGMWQ3byxwPWtWMEQ5aTdWUStFS1JweldIalNYMWRSclpNVVYzTW9iZE4zV3NWTjNNWmc9</response>

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

2019-11-25 19:13:08 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:08 | [Mutex] notify: [event, disconnected]

2019-11-25 19:13:08 | [Mutex] received everything.

2019-11-25 19:13:08 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:08 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj0zTVFHNXJjRlh2V3pVWmc4UktRUQ==</auth>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zTVFHNXJjRlh2V3pVWmc4UktRUWZNaGpuSWtKZnZoajZ6VUdJVHZoLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M01RRzVyY0ZYdld6VVpnOFJLUVFmTWhqbklrSmZ2aGo2elVHSVR2aCxwPWlTTXRpeDlOV0QxWDVuK0I2VFdyRTRlbVU4YVRPRi8zanp1NlRmTlAzWWM9</response>

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

2019-11-25 19:13:08 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:08 | [Mutex] received everything.

2019-11-25 19:13:08 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:08 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1mUDNINVlEMzRDdG5VdEpJVlp0cw==</auth>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mUDNINVlEMzRDdG5VdEpJVlp0czY4YkhCRks4Mm5mVnlWbldGVU1DLHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZlAzSDVZRDM0Q3RuVXRKSVZadHM2OGJIQkZLODJuZlZ5Vm5XRlVNQyxwPU5qRkdxdTJvQzVzM3RYTjAveEh0MWpIbTJiaFFHZFFhZDcrRTVzUkVwdWs9</response>

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

2019-11-25 19:13:08 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:08 | [Mutex] received everything.

2019-11-25 19:13:08 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX282eWh6ejAwMjcscj1DRmhDOG5HaVhobHR4ajZzUHNRag==</auth>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DRmhDOG5HaVhobHR4ajZzUHNRalNoN0VhcWVwOXMwOURDdWdid1h1LHM9dzYwN2Vqa2FIWmh0Ync9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:08 | user :: user_o6yhzz0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q0ZoQzhuR2lYaGx0eGo2c1BzUWpTaDdFYXFlcDlzMDlEQ3VnYndYdSxwPTh1Z0VpMmJjSnhDNzYrODZ3UEk5ZlRyVmFBZEZUSjZaWEY4MlAvN2RSSGM9</response>

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

2019-11-25 19:13:10 | [Mutex] waiting for: [user]

2019-11-25 19:13:10 | [Mutex] received everything.

2019-11-25 19:13:10 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-25 19:13:10 |

2019-11-25 19:13:10 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 19:13:10 | ------------------------------------

2019-11-25 19:13:10 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@32b0a17b

2019-11-25 19:13:10 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c77595d}, 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@3848ca0b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d4a5366}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4a468ecd}, 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=Mon Nov 25 19:13:10 PST 2019}}}}

2019-11-25 19:13:10 | [Mutex] waiting for: [registration]

2019-11-25 19:13:10 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4cfd8b69

2019-11-25 19:13:10 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c77595d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@3848ca0b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d4a5366}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4a468ecd}, 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=Mon Nov 25 19:13:10 PST 2019}}}}

2019-11-25 19:13:10 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@321b086f

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

2019-11-25 19:13:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d65ac29}

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

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

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

2019-11-25 19:13:11 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@632b79ae

2019-11-25 19:13:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@432d1061

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

2019-11-25 19:13:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@291f201b}

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

2019-11-25 19:13:11 | user :: null >> <iq to="localhost" id="S149xgEzDBk04rl7xcPHJRO" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 19:13:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4741d937}

2019-11-25 19:13:11 | user :: null << <iq type="result" id="S149xgEzDBk04rl7xcPHJRO" 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-11-25 19:13:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@192bd5f5}

2019-11-25 19:13:11 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@21f52977

2019-11-25 19:13:11 | user :: null >> <iq to="localhost" id="GDSQ0dSX00exyzDjRUW9NVY" type="set"><query xmlns="jabber:iq:register"><username>user_ovc250028</username><password>user_ovc250028</password><email>5a599d37-c2f3-45b0-91c7-d1b3ad6e6235@localhost</email></query></iq>

2019-11-25 19:13:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4df5ae0}

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

2019-11-25 19:13:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@af08b30}

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

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

2019-11-25 19:13:11 | 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;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d65ac29, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@291f201b]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c77595d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@3848ca0b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d4a5366}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4a468ecd}, 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=Mon Nov 25 19:13:11 PST 2019}}}}

2019-11-25 19:13:11 | 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;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c77595d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@3848ca0b}, urn:xmpp:sm:3#SM_ACK_ENABLED=Entry{scope=stream, value=false}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d4a5366}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4a468ecd}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:13:11 PST 2019}}}}

2019-11-25 19:13:11 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5abf6d8d

2019-11-25 19:13:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1dfc9f52

2019-11-25 19:13:11 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@154aa30b

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 19:13:11 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1b6d1399

2019-11-25 19:13:11 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3a1fc67c

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX292YzI1MDAyOCxyPURmdVNDclJ4YUtCUkROSFdBa25P</auth>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EZnVTQ3JSeGFLQlJETkhXQWtuT0oxYXprUmtWMlh5N0Y5OVpkSXJ0LHM9RVc0Qk44VHkwNW9ZbXc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RGZ1U0NyUnhhS0JSRE5IV0Frbk9KMWF6a1JrVjJYeTdGOTlaZElydCxwPUowMEtvTHB0d3p5cFhKZ2krc2x4WEtLbXlYZ3V5eUhTWjBRUllVZ3pSN009</response>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1MQitMaVRuZzR1Rm1lMi9Tek1YbUpzK0IxRklmRjV6RGU4MVdDQ0o1M2NVPQ==</success>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" xmlns="http://jabber.org/protocol/caps"/></features>

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

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

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost/993927746-tigase-20 << <iq to="user_ovc250028@localhost/993927746-tigase-20" type="result" id="wDOTfV9qhBxt2cIDIDmIEne" xmlns="jabber:client"/>

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

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost/993927746-tigase-20 << <enabled max="60" resume="true" id="d278d050-f97c-458e-bcb6-3caee2c778f4" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost/993927746-tigase-20 >> <iq id="MHWQUTgZtZdCmZthGIuh1tf" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

2019-11-25 19:13:11 | Disconnecting

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

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

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

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

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX292YzI1MDAyOCxyPW5XWVNoRVhFV05mWWNvRWsydWZ0</auth>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uV1lTaEVYRVdOZlljb0VrMnVmdHBzVDF4cFJIbDRpdHVVd0F6OFZPLHM9RVc0Qk44VHkwNW9ZbXc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bldZU2hFWEVXTmZZY29FazJ1ZnRwc1QxeHBSSGw0aXR1VXdBejhWTyxwPUU1VkJRRG43RDFjZzA0S0VkZjc1OFZ4azZVZnhzTW95MHF6b2tpc01tc0U9</response>

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

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

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

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

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

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX292YzI1MDAyOCxyPWtQdXJRaGNoTXZidmtRSFlKaU1J</auth>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rUHVyUWhjaE12YnZrUUhZSmlNSTVyb080Sk9LQ1N6TWlDRXFxbUZQLHM9RVc0Qk44VHkwNW9ZbXc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a1B1clFoY2hNdmJ2a1FIWUppTUk1cm9PNEpPS0NTek1pQ0VxcW1GUCxwPVRBYmJtSkZKNjhMRmE2WXlYN3RKNnJXN2NSRHdMcEN4MDNXU0FCQkdJZ0E9</response>

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

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

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

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

2019-11-25 19:13:11 | [Mutex] notify: [event, disconnected]

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

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX292YzI1MDAyOCxyPVFsYzlVTUZnQUxFNzF1c1JYSGdq</auth>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RbGM5VU1GZ0FMRTcxdXNSWEhnalFEQzJNN3ZxWmlSb2s1RGhmQ2JxLHM9RVc0Qk44VHkwNW9ZbXc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UWxjOVVNRmdBTEU3MXVzUlhIZ2pRREMyTTd2cVppUm9rNURoZkNicSxwPVljc2dlSEQ0T2tuQjNNS3BPdUs5VXJKb0g2TDJuRFFnb2JuLzk1OTd3a009</response>

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

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

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

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

2019-11-25 19:13:11 | [Mutex] notify: [event, disconnected]

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

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

2019-11-25 19:13:11 | user :: user_ovc250028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:12 | user :: user_ovc250028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX292YzI1MDAyOCxyPWZYV0VCZFhhNHZtM2ZOcjFlVnRl</auth>

2019-11-25 19:13:12 | user :: user_ovc250028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mWFdFQmRYYTR2bTNmTnIxZVZ0ZUFkbVgzODhSeVlSQnpDOUh6WEZBLHM9RVc0Qk44VHkwNW9ZbXc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:12 | user :: user_ovc250028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZlhXRUJkWGE0dm0zZk5yMWVWdGVBZG1YMzg4UnlZUkJ6QzlIelhGQSxwPWprN0c3SzZYUEcyaS9Qc0FadmZ3SXVTcXNFRDh3U0h0czVmbzlsMG5KRU09</response>

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

2019-11-25 19:13:12 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:12 | [Mutex] notify: [event, disconnected]

2019-11-25 19:13:12 | [Mutex] received everything.

2019-11-25 19:13:12 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-25 19:13:12 | user :: user_ovc250028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:12 | user :: user_ovc250028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX292YzI1MDAyOCxyPVl0UklpczVLVHRzbnZjNThSelI4</auth>

2019-11-25 19:13:12 | user :: user_ovc250028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZdFJJaXM1S1R0c252YzU4UnpSOHYzYzBSMGNDT0ZtSW1RdWNobElsLHM9RVc0Qk44VHkwNW9ZbXc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:12 | user :: user_ovc250028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WXRSSWlzNUtUdHNudmM1OFJ6Ujh2M2MwUjBjQ09GbUltUXVjaGxJbCxwPVp2Y0dGSjVYcFFFeFg3RGFCT01QTjZsVTlJRmhuNmFqQWE4NFJXQ1EwYVE9</response>

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

2019-11-25 19:13:14 | [Mutex] waiting for: [user]

2019-11-25 19:13:14 | [Mutex] received everything.

2019-11-25 19:13:14 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-25 19:13:14 |

2019-11-25 19:13:14 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 19:13:14 | ------------------------------------

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@70d68f00

2019-11-25 19:13:14 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7e116f6a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@7a2ee470}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3f2c6551}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bc6433b}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:13:14 PST 2019}}}}

2019-11-25 19:13:14 | [Mutex] waiting for: [registration]

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@e591916

2019-11-25 19:13:14 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7e116f6a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@7a2ee470}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3f2c6551}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bc6433b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:13:14 PST 2019}}}}

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@35961c9

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

2019-11-25 19:13:14 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5f039a1e}

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

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

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

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1695c55e

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5042ef33

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

2019-11-25 19:13:14 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@185d8bdb}

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

2019-11-25 19:13:14 | user :: null >> <iq to="localhost" id="0IT3zzr0rVbLCm2h0dw2iFO" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 19:13:14 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@78046ba9}

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5b4d21a4

2019-11-25 19:13:14 | user :: null << <iq type="result" id="0IT3zzr0rVbLCm2h0dw2iFO" 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-11-25 19:13:14 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@63caa0a6}

2019-11-25 19:13:14 | user :: null >> <iq to="localhost" id="BN6BfP3cwmViNGmWXofZ1hK" type="set"><query xmlns="jabber:iq:register"><username>user_hfihgs0029</username><password>user_hfihgs0029</password><email>e48103c9-3127-4cb5-a2ef-78cf343c84ce@localhost</email></query></iq>

2019-11-25 19:13:14 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7073c176}

2019-11-25 19:13:14 | user :: null << <iq type="result" id="BN6BfP3cwmViNGmWXofZ1hK" from="localhost" xmlns="jabber:client"/>

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

2019-11-25 19:13:14 | [Mutex] received everything.

2019-11-25 19:13:14 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 19:13:14 | 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;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5f039a1e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@185d8bdb]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7e116f6a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@7a2ee470}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3f2c6551}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bc6433b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:13:14 PST 2019}}}}

2019-11-25 19:13:14 | 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;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5f039a1e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@185d8bdb]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7e116f6a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@7a2ee470}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3f2c6551}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bc6433b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:13:14 PST 2019}}}}

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5041a495

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6233ff38

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@54cabc48

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@47ebac72

2019-11-25 19:13:14 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1a53dd16

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

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hmaWhnczAwMjkscj1WazFCY3ROTDNaMzNFYUZzSXdyMQ==</auth>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WazFCY3ROTDNaMzNFYUZzSXdyMTJoaXdNZ0FXM054UTJicjBTRks4LHM9bFBUT1h0VHpDUnN3YlE9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VmsxQmN0TkwzWjMzRWFGc0l3cjEyaGl3TWdBVzNOeFEyYnIwU0ZLOCxwPVBDRWpaRCt0cVY3YlhaY0pmSXhCYkV2MVRDK2h1ZERNZnkzTUpSZ3VYUnc9</response>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj00SFZyRGR6MEhlQmk1WmE4b1JGRDVsU1BPZkN5M01kZnMxbnQ1N1RROFZzPQ==</success>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost >> <iq xmlns="jabber:client" id="JTm8t24mN4BHr7qYdVbukIJ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost << <iq to="user_hfihgs0029@localhost/993927746-tigase-21" type="result" id="JTm8t24mN4BHr7qYdVbukIJ" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_hfihgs0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="10FLXdyx7zxaseFMLCeGrmb" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost/993927746-tigase-21 << <iq to="user_hfihgs0029@localhost/993927746-tigase-21" type="result" id="10FLXdyx7zxaseFMLCeGrmb" xmlns="jabber:client"/>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="jN0snfxjOKL1nS6gP7FDodt" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost/993927746-tigase-21 << <enabled max="60" resume="true" id="142b475b-ed4a-43d1-b24d-7975137b81f2" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost/993927746-tigase-21 >> <iq id="98Z2cIDIDmIEneVlJHAiRdL" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost/993927746-tigase-21 << <iq to="user_hfihgs0029@localhost/993927746-tigase-21" type="result" id="98Z2cIDIDmIEneVlJHAiRdL" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:13:14 | Disconnecting

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

2019-11-25 19:13:14 | [Mutex] notify: [disconnected]

2019-11-25 19:13:14 | [Mutex] received everything.

2019-11-25 19:13:14 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:14 | user :: user_hfihgs0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfaGZpaGdzMDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-25 19:13:15 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:15 | [Mutex] notify: [event, disconnected]

2019-11-25 19:13:15 | [Mutex] received everything.

2019-11-25 19:13:15 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:15 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2hmaWhnczAwMjkscj15a2U4OVYwWFJjZk56cWN3b052dA==</auth>

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15a2U4OVYwWFJjZk56cWN3b052dG5vb2N3cmo3aFZtaWZ2MDg0VHVOLHM9WlNzeEs5SXBkYm90b0E9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eWtlODlWMFhSY2ZOenFjd29OdnRub29jd3JqN2hWbWlmdjA4NFR1TixwPUIvYkU3eGZnZldhM0thK0dNZHFKRWU4M2JUND0=</response>

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

2019-11-25 19:13:15 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:15 | [Mutex] received everything.

2019-11-25 19:13:15 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:15 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2hmaWhnczAwMjkscj03Vjk4akN1MnpnbnRpU2RxVGpDeg==</auth>

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03Vjk4akN1MnpnbnRpU2RxVGpDekF0N3k0SXJVTjhPZmRtaGJ0RkRzLHM9WlNzeEs5SXBkYm90b0E9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N1Y5OGpDdTJ6Z250aVNkcVRqQ3pBdDd5NElyVU44T2ZkbWhidEZEcyxwPUdlaUZpckZQKzZ5NnBkVlBPTHBIVndMWEp3QT0=</response>

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

2019-11-25 19:13:15 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:15 | [Mutex] received everything.

2019-11-25 19:13:15 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:15 | [Mutex] waiting for: [event]

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

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hmaWhnczAwMjkscj1Db3dheXF6eHhIVXlGOFd4RDc5Wg==</auth>

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Db3dheXF6eHhIVXlGOFd4RDc5WloxYXdCUTBCTk9KdHFYWFBOZXdELHM9bFBUT1h0VHpDUnN3YlE9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q293YXlxenh4SFV5RjhXeEQ3OVpaMWF3QlEwQk5PSnRxWFhQTmV3RCxwPWFaamV2bjNkMUREU2dlbC8yNUx1a3ZxVU9sWi9EL2FXOTNXMndFOXgweVU9</response>

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

2019-11-25 19:13:15 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:15 | [Mutex] received everything.

2019-11-25 19:13:15 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:15 | [Mutex] notify: [event, disconnected]

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

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hmaWhnczAwMjkscj1CQWQyaUVhOTd0YmZ3bWdoMlhDOQ==</auth>

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CQWQyaUVhOTd0YmZ3bWdoMlhDOUoxVTNMdFBaMktFTms5SG93d0NNLHM9bFBUT1h0VHpDUnN3YlE9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:15 | user :: user_hfihgs0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QkFkMmlFYTk3dGJmd21naDJYQzlKMVUzTHRQWjJLRU5rOUhvd3dDTSxwPXVBUk9nQ2lOcnFMQXg2RXpkZEdQbWhHK2tYcTZ1N1hpQWN1UEM3cXJyN289</response>

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

2019-11-25 19:13:17 | [Mutex] waiting for: [user]

2019-11-25 19:13:17 | [Mutex] received everything.

2019-11-25 19:13:17 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-25 19:13:17 |

2019-11-25 19:13:17 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 19:13:17 | ------------------------------------

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@45bbd12c

2019-11-25 19:13:17 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b7c37eb}, 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@4f43ba5c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@a413dd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1168bf05}, 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=Mon Nov 25 19:13:17 PST 2019}}}}

2019-11-25 19:13:17 | [Mutex] waiting for: [registration]

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3b0111ac

2019-11-25 19:13:17 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b7c37eb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@4f43ba5c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@a413dd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1168bf05}, 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=Mon Nov 25 19:13:17 PST 2019}}}}

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@69c2cdca

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

2019-11-25 19:13:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6a6ec29f}

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

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

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

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3eaad840

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@d953248

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

2019-11-25 19:13:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@72c602ad}

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

2019-11-25 19:13:17 | user :: null >> <iq to="localhost" id="zd8xcPHJROKOP6pUOQL0trV" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 19:13:17 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@56836d1b}

2019-11-25 19:13:17 | user :: null << <iq type="result" id="zd8xcPHJROKOP6pUOQL0trV" 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-11-25 19:13:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6e205c50}

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6a0e10c

2019-11-25 19:13:17 | user :: null >> <iq to="localhost" id="46LCFn5zeAubOPKuctqj7hN" type="set"><query xmlns="jabber:iq:register"><username>user_ymab5z0030</username><password>user_ymab5z0030</password><email>b71d99d5-72c2-45cc-9bd4-3e1d28e73b44@localhost</email></query></iq>

2019-11-25 19:13:17 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3c0a4978}

2019-11-25 19:13:17 | user :: null << <iq type="result" id="46LCFn5zeAubOPKuctqj7hN" from="localhost" xmlns="jabber:client"/>

2019-11-25 19:13:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@220384e2}

2019-11-25 19:13:17 | [Mutex] received everything.

2019-11-25 19:13:17 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 19:13:17 | 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;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6a6ec29f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@72c602ad]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b7c37eb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@4f43ba5c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@a413dd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1168bf05}, 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=Mon Nov 25 19:13:17 PST 2019}}}}

2019-11-25 19:13:17 | 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;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6a6ec29f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@72c602ad]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b7c37eb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@4f43ba5c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@a413dd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1168bf05}, 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=Mon Nov 25 19:13:17 PST 2019}}}}

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@60123965

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@cbc3beb

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@d9503f1

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@338fb235

2019-11-25 19:13:17 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@42277c30

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

2019-11-25 19:13:17 | user :: user_ymab5z0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 19:13:17 | user :: user_ymab5z0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ltYWI1ejAwMzAscj1vaW00QmRBSzdrYU5TNGlHcVVmRg==</auth>

2019-11-25 19:13:17 | user :: user_ymab5z0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vaW00QmRBSzdrYU5TNGlHcVVmRm04R1pxNUZua1hKUWZsOWRVZUJaLHM9RmtRejAvYjFWaEhveGc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:17 | user :: user_ymab5z0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b2ltNEJkQUs3a2FOUzRpR3FVZkZtOEdacTVGbmtYSlFmbDlkVWVCWixwPVNGa2IxblpEK0FCQU9nOG9GdHFYZy90aVB0SkxtTjZES2huc295ejJ4KzA9</response>

2019-11-25 19:13:17 | user :: user_ymab5z0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1SaHBVZDFVb2FNdWN4NXIxWERLRkJrTHQrMnZIVkkyY2hnL1I4aUh2WGZZPQ==</success>

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

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost >> <iq xmlns="jabber:client" id="NORUTgZtZdCmZthGIuh1tfC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost << <iq to="user_ymab5z0030@localhost/993927746-tigase-22" type="result" id="NORUTgZtZdCmZthGIuh1tfC" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_ymab5z0030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="kjk5FnZasbR3eOGFN1lO39D" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-22 << <iq to="user_ymab5z0030@localhost/993927746-tigase-22" type="result" id="kjk5FnZasbR3eOGFN1lO39D" xmlns="jabber:client"/>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="zhcFslJNZ4gQTeFqQUTgZtZ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-22 << <enabled max="60" resume="true" id="fb1714c6-4e23-457d-b547-509b2486cabb" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-22 >> <iq id="GXcuiN2hEiOHSdVT1eArn5i" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-22 << <iq to="user_ymab5z0030@localhost/993927746-tigase-22" type="result" id="GXcuiN2hEiOHSdVT1eArn5i" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:13:18 | Disconnecting

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

2019-11-25 19:13:18 | [Mutex] notify: [disconnected]

2019-11-25 19:13:18 | [Mutex] received everything.

2019-11-25 19:13:18 | [Mutex] waiting for: [event]

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

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

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

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ltYWI1ejAwMzAscj1NYUtxQ2lrVDBUcGE4aUh2ejZTMg==</auth>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NYUtxQ2lrVDBUcGE4aUh2ejZTMkZ5cVJpbk5ud3c3NExhYTAzeHowLHM9RmtRejAvYjFWaEhveGc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TWFLcUNpa1QwVHBhOGlIdno2UzJGeXFSaW5Obnd3NzRMYWEwM3h6MCxwPWlrTXBQS0VKcWwrMHQ4R25VZ29UK0lBTTIyQVZyeTNvQnowVFRqazExTlk9</response>

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

2019-11-25 19:13:18 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:18 | [Mutex] received everything.

2019-11-25 19:13:18 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:18 | [Mutex] waiting for: [event]

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

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

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

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ltYWI1ejAwMzAscj1UZFZNamVTUU1RSHRFeWkxdmhyTA==</auth>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UZFZNamVTUU1RSHRFeWkxdmhyTG1KN0FuNXBZUTBYTDhKYUg1UGJxLHM9RmtRejAvYjFWaEhveGc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VGRWTWplU1FNUUh0RXlpMXZockxtSjdBbjVwWVEwWEw4SmFINVBicSxwPXh2Mkx3Wmo4U2o3eGdUQUYyTWNkN2YvQnZTSU1UWXlLUllxOFBRV3B6a1E9</response>

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

2019-11-25 19:13:18 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:18 | [Mutex] received everything.

2019-11-25 19:13:18 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 19:13:18 | [Mutex] waiting for: [event]

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

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

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

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ltYWI1ejAwMzAscj0zRmRCbk55NHBGNG85b1RzbDVBMQ==</auth>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zRmRCbk55NHBGNG85b1RzbDVBMU1qcFkxNXYxdWU2QVRxaU5BZloyLHM9RmtRejAvYjFWaEhveGc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M0ZkQm5OeTRwRjRvOW9Uc2w1QTFNanBZMTV2MXVlNkFUcWlOQWZaMixwPXhLSGxHYmJUbVpHWUFRMUx3cWp3ZFlYMnRRRmlCaHZLQ2NremRDNWJEeTg9</response>

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

2019-11-25 19:13:18 | [Mutex] notify: [event, authFailed]

2019-11-25 19:13:18 | [Mutex] received everything.

2019-11-25 19:13:18 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ltYWI1ejAwMzAscj01UmFtVElONW12cXJrblR2YWVYdw==</auth>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01UmFtVElONW12cXJrblR2YWVYd2ZBcU9PMVlXWkluTFRoUk1hdUtELHM9RmtRejAvYjFWaEhveGc9PSxpPTQwOTY=</challenge>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NVJhbVRJTjVtdnFya25UdmFlWHdmQXFPTzFZV1pJbkxUaFJNYXVLRCxwPWZhOGpuZHNBaUI3cGFjS09nbWRZb3FjNXVyQ2pITjltNzZnQXZza1VxVms9</response>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj12QWVrNTdWMGZRQUVrTVIwMkFNSCtHUWhrbE55eGJMaUo4RHZFMm03K1lrPQ==</success>

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

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost >> <iq xmlns="jabber:client" id="snq9qcsdTdJABfP3cwmViNG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost << <iq to="user_ymab5z0030@localhost/993927746-tigase-23" type="result" id="snq9qcsdTdJABfP3cwmViNG" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_ymab5z0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="3kfLEJvl5gECrkROCsZsnfx" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-23 << <iq to="user_ymab5z0030@localhost/993927746-tigase-23" type="result" id="3kfLEJvl5gECrkROCsZsnfx" xmlns="jabber:client"/>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="q2lVl1aGq9LXdyx7zxaseFM" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-23 << <enabled max="60" resume="true" id="47cd1f70-190b-4e8b-852a-9a23dd6fe0a7" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-23 >> <iq id="0ZaBFLPMZ1n9oU8toZ48u3A" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-25 19:13:18 | user :: user_ymab5z0030@localhost/993927746-tigase-23 << <iq to="user_ymab5z0030@localhost/993927746-tigase-23" type="result" id="0ZaBFLPMZ1n9oU8toZ48u3A" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:13:18 | Disconnecting

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

2019-11-25 19:13:18 | [Mutex] notify: [disconnected]

2019-11-25 19:13:18 | [Mutex] received everything.

2019-11-25 19:13:20 | [Mutex] waiting for: [user]

2019-11-25 19:13:20 | [Mutex] received everything.

2019-11-25 19:13:20 | [Mutex] isItemNotified: user:ok:true :: true