Brute Force Prevention

2019-11-20 18:36:57 |

2019-11-20 18:36:57 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-20 18:36:57 | ------------------------------------

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@30ca4589

2019-11-20 18:36:57 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29586656}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3e0dade0}, 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@3a322ef9}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7f30a7db}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1d3443b9}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:36:57 PST 2019}}}}

2019-11-20 18:36:57 | [Mutex] waiting for: [registration]

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4e059f52

2019-11-20 18:36:57 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3e0dade0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@3a322ef9}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7f30a7db}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1d3443b9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:36:57 PST 2019}}}}

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@65eb258d

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

2019-11-20 18:36:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f1f5894}

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

2019-11-20 18:36:57 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-20 18:36:57 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2009e945

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@42140d19

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

2019-11-20 18:36:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7eef8f9b}

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

2019-11-20 18:36:57 | user :: null >> <iq to="localhost" id="qSTdzpXctW4o3lS39odIQ7l" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-20 18:36:57 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@58ca05e7}

2019-11-20 18:36:57 | user :: null << <iq id="qSTdzpXctW4o3lS39odIQ7l" type="result" 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-20 18:36:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1b51a32a}

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@74fd22c4

2019-11-20 18:36:57 | user :: null >> <iq to="localhost" id="XSRPVZgBcAq7t8zbslYm9pQ" type="set"><query xmlns="jabber:iq:register"><username>user_vzuqeb0027</username><password>user_vzuqeb0027</password><email>f495fb0d-c195-43ca-911f-103991a037b6@localhost</email></query></iq>

2019-11-20 18:36:57 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@32d8a5f5}

2019-11-20 18:36:57 | user :: null << <iq id="XSRPVZgBcAq7t8zbslYm9pQ" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-20 18:36:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@16638587}

2019-11-20 18:36:57 | [Mutex] received everything.

2019-11-20 18:36:57 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-20 18:36:57 | 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;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f1f5894, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7eef8f9b]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3e0dade0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@3a322ef9}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7f30a7db}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1d3443b9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:36:57 PST 2019}}}}

2019-11-20 18:36:57 | 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;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f1f5894, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7eef8f9b]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3e0dade0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@3a322ef9}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7f30a7db}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1d3443b9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:36:57 PST 2019}}}}

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@14f24387

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@22cfac0

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1fda0343

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@159fe282

2019-11-20 18:36:57 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@13f765cd

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

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1KdVlDSDVJTGhqanJybTBZZFhSUA==</auth>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KdVlDSDVJTGhqanJybTBZZFhSUDZDSWtyMjB5RGF4MDNsa2FWU01QLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SnVZQ0g1SUxoampycm0wWWRYUlA2Q0lrcjIweURheDAzbGthVlNNUCxwPTl2QzZhdmZyaFBLNVVlOXYrU0RtWjNMK0J3VzFHSi9TU2xKaGFlNTc5aWs9</response>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj12V29jVHRjck9tQzU0bThIRTRtSVFHbm85cXZVQnZkRjlwdEZZTmdrZHM4PQ==</success>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@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 ver="8SAx7sxxLI3422mjAeBbH2oWxJg=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost >> <iq xmlns="jabber:client" id="oQJwwv9zhQLweIHDsdt2vi0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost << <iq id="oQJwwv9zhQLweIHDsdt2vi0" to="user_vzuqeb0027@localhost/993927746-tigase-19" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_vzuqeb0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="OOBEADHskKYpXbviFkQW9xg" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost/993927746-tigase-19 << <iq id="OOBEADHskKYpXbviFkQW9xg" to="user_vzuqeb0027@localhost/993927746-tigase-19" type="result" xmlns="jabber:client"/>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="4JkRU7hEJKUfBeWZlaCHPIQ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost/993927746-tigase-19 << <enabled max="60" id="d2a2c25c-331f-4dad-971f-caeca8905a6a" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost/993927746-tigase-19 >> <iq id="kLodRMY2yzhPNSPEueJHAtZ" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-20 18:36:57 | user :: user_vzuqeb0027@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-20 18:36:57 | user :: user_vzuqeb0027@localhost/993927746-tigase-19 << <iq id="kLodRMY2yzhPNSPEueJHAtZ" to="user_vzuqeb0027@localhost/993927746-tigase-19" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 18:36:57 | Disconnecting

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

2019-11-20 18:36:57 | [Mutex] notify: [disconnected]

2019-11-20 18:36:57 | [Mutex] received everything.

2019-11-20 18:36:57 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1pQUxibTE2bkV6NHkxbm1UekRGaQ==</auth>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pQUxibTE2bkV6NHkxbm1UekRGaUhQY2U1NWxKQXl2VnZNWG93dGRhLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aUFMYm0xNm5FejR5MW5tVHpERmlIUGNlNTVsSkF5dlZ2TVhvd3RkYSxwPXBSVC82aC9sNjIzdFdIQ0JtTnNVSFNPblVVbm5FbEhwSUUreThBUzZ0cDQ9</response>

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:57 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:57 | [Mutex] received everything.

2019-11-20 18:36:57 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:57 | [Mutex] notify: [event, disconnected]

2019-11-20 18:36:57 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:57 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1ETmpwcjhRTDhXZ0RpM0t2aUJtMA==</auth>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ETmpwcjhRTDhXZ0RpM0t2aUJtMGc4d2swWWpWZGJtZG11cDF6QjdJLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RE5qcHI4UUw4V2dEaTNLdmlCbTBnOHdrMFlqVmRibWRtdXAxekI3SSxwPVZzcXMrVUkyamowUEJ3dzBEeWJnWFpXUjdOa3ZYdFpCanA0Z3J5YStDcG89</response>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:58 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:58 | [Mutex] received everything.

2019-11-20 18:36:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:58 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj12MWhMVHRrVkR5SlhsYk9TS0JsMQ==</auth>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12MWhMVHRrVkR5SlhsYk9TS0JsMUdGSENGRm8yVnVCZnNrRXdaVHBnLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9djFoTFR0a1ZEeUpYbGJPU0tCbDFHRkhDRkZvMlZ1QmZza0V3WlRwZyxwPUZvSXhDSG9hZURkVlZSVVdBMml0UERkMDNpeWJSWktMSU5ROHRUVWJzMFk9</response>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:58 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:58 | [Mutex] received everything.

2019-11-20 18:36:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:58 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1zTHlxaTA2ZDYzb0F6MUVCekJmTg==</auth>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zTHlxaTA2ZDYzb0F6MUVCekJmTklSY2FEa3MyNzVGdDBwQmxubGpoLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c0x5cWkwNmQ2M29BejFFQnpCZk5JUmNhRGtzMjc1RnQwcEJsbmxqaCxwPVJhd1VZSmRHZi92TzNGN0xaZ0llcFlNanJkdVNleHd0ay9nY3NPMkRTSlk9</response>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:58 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:58 | [Mutex] received everything.

2019-11-20 18:36:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:58 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1zVGV6M0xqSVIzd2haNHdCWVk3dA==</auth>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zVGV6M0xqSVIzd2haNHdCWVk3dHpVZHNFSWprVjBpQURwaHAzcXlLLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c1RlejNMaklSM3doWjR3QllZN3R6VWRzRUlqa1YwaUFEcGhwM3F5SyxwPWhtcUlBczNLc2ZqNStaL2w3WUFFQmFBTEg4MFF2T0Y0VXgyR0Y4VUF1MVE9</response>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:58 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:58 | [Mutex] received everything.

2019-11-20 18:36:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:58 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1VOERDQ3h1aTQxeDZWYjhtY1hrRw==</auth>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VOERDQ3h1aTQxeDZWYjhtY1hrRzJqZGJyZzlLRGx4YklFZWhRUXVNLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VThEQ0N4dWk0MXg2VmI4bWNYa0cyamRicmc5S0RseGJJRWVoUVF1TSxwPVBWbUVvWVNKWTE5eUNvVW1UbVBDU2JUK2pJb1cyNE96V2pYeWFMQkc2d0k9</response>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:58 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:58 | [Mutex] received everything.

2019-11-20 18:36:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:58 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1RN0JzN3RRNlRjeFgwbDQ5dVM2SQ==</auth>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RN0JzN3RRNlRjeFgwbDQ5dVM2SVNMZlZtdnFSMUxTbUxTRnE5dEphLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UTdCczd0UTZUY3hYMGw0OXVTNklTTGZWbXZxUjFMU21MU0ZxOXRKYSxwPS93VmhKNis4SjRtNFk4eUc0aFZhQ0ZnNTJnVnN3c3RYSWZRMW4wcHB2K0U9</response>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:58 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:58 | [Mutex] received everything.

2019-11-20 18:36:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:58 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj03OGRrQ3pXbm41R2xlZGg0aXprTw==</auth>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03OGRrQ3pXbm41R2xlZGg0aXprT0Jmbkx3cWJabGNRb3VFRVpPMGZOLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Nzhka0N6V25uNUdsZWRoNGl6a09CZm5Md3FiWmxjUW91RUVaTzBmTixwPXd2U1Rjb2tHcy80OWhIUkJqZzBiWWVaQ0JCMVFaTHFjbnJkOFpsNmRiQVk9</response>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:58 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:58 | [Mutex] received everything.

2019-11-20 18:36:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:58 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1CRDRqVDl2ME9nQ05UOGxaRmRNTg==</auth>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CRDRqVDl2ME9nQ05UOGxaRmRNTmk1U1B4UGd6TTFyblZDNmlyeWhILHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QkQ0alQ5djBPZ0NOVDhsWkZkTU5pNVNQeFBnek0xcm5WQzZpcnloSCxwPUs3cWFwT3FENVVpRzZGTHhWdk8wTHlXbUNwTVE1cDBEclNUMVdJYlhqcDg9</response>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:58 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:58 | [Mutex] received everything.

2019-11-20 18:36:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:58 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1rQzdycG1WRTlDZWluNFRtZFFEeg==</auth>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rQzdycG1WRTlDZWluNFRtZFFEem9IcHNjTHNRa2RlanhkajBiQzdnLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a0M3cnBtVkU5Q2VpbjRUbWRRRHpvSHBzY0xzUWtkZWp4ZGowYkM3ZyxwPTcvS3l5MktIUFkraTM3L2hiNmRWU3ZZV3JCdG1WbXBrcm5ZMEg0dnBpeGc9</response>

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:58 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:58 | [Mutex] received everything.

2019-11-20 18:36:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:58 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:58 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1hRURkcDRRQWs2N053dVFXbk1EUw==</auth>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hRURkcDRRQWs2N053dVFXbk1EU2dQa3EyOG9raXZ2ZmJhUTlEUlpFLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YUVEZHA0UUFrNjdOd3VRV25NRFNnUGtxMjhva2l2dmZiYVE5RFJaRSxwPVg2WTdQTldweWM4MDJLblQxczFKby9MTmN3RHVkaEVtdFY0eE9Nc0pFcEU9</response>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:59 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:59 | [Mutex] received everything.

2019-11-20 18:36:59 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:59 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1mRjBUSUVoSzl6UkpETGpWUEc2bA==</auth>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mRjBUSUVoSzl6UkpETGpWUEc2bDBXbXNMVHR0T1F2YWI2WmpYZjNqLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZkYwVElFaEs5elJKRExqVlBHNmwwV21zTFR0dE9RdmFiNlpqWGYzaixwPVM3TXdTZUo1eW50ZFFacTdkS01sUUtlWlAwZk1rLy94TldNTm1nMzJISm89</response>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:59 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:59 | [Mutex] received everything.

2019-11-20 18:36:59 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:59 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1KR09qOGFGeFJMV3k3bUtpUkNhTw==</auth>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KR09qOGFGeFJMV3k3bUtpUkNhT0Jxc2pyYzdpRHVRNWN0andjdUVLLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SkdPajhhRnhSTFd5N21LaVJDYU9CcXNqcmM3aUR1UTVjdGp3Y3VFSyxwPVcrTStJcUF0U2ZrS3F6TTliVmJoTHZqa0JIRGdXOHcwSklGSTBFbUN1UWM9</response>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:59 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:59 | [Mutex] received everything.

2019-11-20 18:36:59 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:59 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1DSlFRSjZaT25wMjZLV3g2eDFENQ==</auth>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DSlFRSjZaT25wMjZLV3g2eDFENUNtbWtTWDZiamZRUjJnS3JVSTJoLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q0pRUUo2Wk9ucDI2S1d4NngxRDVDbW1rU1g2YmpmUVIyZ0tyVUkyaCxwPWR3UTJuTUZFV1k5OWV6b21VaFYwcVZ6TEpMQ1ZHWk9Dck8zejczcU8rVWc9</response>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:59 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:59 | [Mutex] received everything.

2019-11-20 18:36:59 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:59 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1KRU04SnRmVXhpamZoQlAybjdYUw==</auth>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KRU04SnRmVXhpamZoQlAybjdYU29KRTJNenlvT05WSnE4RmJXYXd4LHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SkVNOEp0ZlV4aWpmaEJQMm43WFNvSkUyTXp5b09OVkpxOEZiV2F3eCxwPW9TcUUzajlubEt5clN6dU9sODNWdkRQeFJURDJkdlRuWnNhOGd0L3QxSzQ9</response>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:59 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:59 | [Mutex] received everything.

2019-11-20 18:36:59 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:59 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1zUUdVYnRibmI3VENTWEtraE5Kag==</auth>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zUUdVYnRibmI3VENTWEtraE5KamR3dVVMU1Rma0g2Z056elFiemdFLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c1FHVWJ0Ym5iN1RDU1hLa2hOSmpkd3VVTFNUZmtINmdOenpRYnpnRSxwPUQ0NUJHQmlYUSsxVW5TTG1hT2ttbUlPVzZmcEVhTFZMVDJCUlcwN3FiUjQ9</response>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:59 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:59 | [Mutex] received everything.

2019-11-20 18:36:59 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:59 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1XV3p3UkNlTnlsZWs0ZUFrRXFJNA==</auth>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XV3p3UkNlTnlsZWs0ZUFrRXFJNG41UHJlSnE0UmJQZDNBdmNQWG9yLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V1d6d1JDZU55bGVrNGVBa0VxSTRuNVByZUpxNFJiUGQzQXZjUFhvcixwPWZ6Y2dPZU9lWEk4VXBCSVlTdEtUQThkSy95TWI4a25Ha2t3NGFNQjdFZk09</response>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:59 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:59 | [Mutex] received everything.

2019-11-20 18:36:59 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:59 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1iUGtiUVp0VkNNcDVUbVI4MU1yNg==</auth>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iUGtiUVp0VkNNcDVUbVI4MU1yNnNMczFTQ3RRTlgxMnZZeTY4aDNCLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YlBrYlFadFZDTXA1VG1SODFNcjZzTHMxU0N0UU5YMTJ2WXk2OGgzQixwPXh2TEhUOS9mUkdmZXNhbTNmK0lDUTN4d3g4cWJnUzJqVjVaYndsdUFkbTQ9</response>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:59 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:59 | [Mutex] received everything.

2019-11-20 18:36:59 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:59 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj03SmFOVW9EdE5JTzRLM2NvckV6Zg==</auth>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03SmFOVW9EdE5JTzRLM2NvckV6ZnVXekVoZ3Q0c3gzcGFkQlduclRuLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N0phTlVvRHROSU80SzNjb3JFemZ1V3pFaGd0NHN4M3BhZEJXbnJUbixwPXdYUXpqcjR5YkRBVjZDdUtYK1IvU01yNitlQlpWVVpYNjVmWElZT1hSODA9</response>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:59 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:59 | [Mutex] received everything.

2019-11-20 18:36:59 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:59 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1vWTZpd2ppSVBQUnFRNjV0WVhEcw==</auth>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vWTZpd2ppSVBQUnFRNjV0WVhEczJXTDBEVzFpWUxZbktpYWhtRmlFLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b1k2aXdqaUlQUFJxUTY1dFlYRHMyV0wwRFcxaVlMWW5LaWFobUZpRSxwPTA2QVNDcFNOdjRKOXZnVDlxTHAxa1cwdW1PbUlsdkNMZGVjQm51Z0V1cmc9</response>

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:36:59 | [Mutex] notify: [event, authFailed]

2019-11-20 18:36:59 | [Mutex] received everything.

2019-11-20 18:36:59 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:36:59 | [Mutex] waiting for: [event]

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

2019-11-20 18:36:59 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:37:00 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj1vM3BXS0xrRnBsaWtWTkxibmp4Qg==</auth>

2019-11-20 18:37:00 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vM3BXS0xrRnBsaWtWTkxibmp4QnlqbHNPRE9BM0tjUmxoVFYwTVplLHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:00 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bzNwV0tMa0ZwbGlrVk5MYm5qeEJ5amxzT0RPQTNLY1JsaFRWME1aZSxwPVlBeFcwNU03dVg1dDgzQmozelZxNXRmY09aZERyNG0yL3E3cSs5ZEhqOXc9</response>

2019-11-20 18:37:00 | user :: user_vzuqeb0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:37:00 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:00 | [Mutex] received everything.

2019-11-20 18:37:00 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-20 18:37:00 | user :: user_vzuqeb0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:37:00 | user :: user_vzuqeb0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Z6dXFlYjAwMjcscj15U1BockVxZ0ZsSDR6VEtaRlhERA==</auth>

2019-11-20 18:37:00 | user :: user_vzuqeb0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15U1BockVxZ0ZsSDR6VEtaRlhERGlhVGNqNUtYSUdkVFk2cVBEemx4LHM9YVdHK1BJbWhpYnluUlE9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:00 | user :: user_vzuqeb0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eVNQaHJFcWdGbEg0elRLWkZYRERpYVRjajVLWElHZFRZNnFQRHpseCxwPU5hTWxHVitmVGZwWjZhYS9BSmpndFJKYklLT00rU294ZXdKcmJBRGVsU0E9</response>

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

2019-11-20 18:37:02 | [Mutex] waiting for: [user]

2019-11-20 18:37:02 | [Mutex] received everything.

2019-11-20 18:37:02 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-20 18:37:02 |

2019-11-20 18:37:02 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-20 18:37:02 | ------------------------------------

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@41834223

2019-11-20 18:37:02 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29586656}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4f44a463}, 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@4b7b2953}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@e79ae58}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@553067ee}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:02 PST 2019}}}}

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3f3da697

2019-11-20 18:37:02 | [Mutex] waiting for: [registration]

2019-11-20 18:37:02 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4f44a463}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@4b7b2953}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@e79ae58}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@553067ee}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:02 PST 2019}}}}

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2d9e3192

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

2019-11-20 18:37:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6e565117}

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

2019-11-20 18:37:02 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-20 18:37:02 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@380f5424

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@6a5454ac

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

2019-11-20 18:37:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@369afad5}

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

2019-11-20 18:37:02 | user :: null >> <iq to="localhost" id="W01t5r1kJs6sbBo5dwteSbt" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-20 18:37:02 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@79c3d206}

2019-11-20 18:37:02 | user :: null << <iq id="W01t5r1kJs6sbBo5dwteSbt" type="result" 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-20 18:37:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6a18cbf8}

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@28741ceb

2019-11-20 18:37:02 | user :: null >> <iq to="localhost" id="7Qv18HGMZ5cSR5EADHskKYp" type="set"><query xmlns="jabber:iq:register"><username>user_rpxe9g0028</username><password>user_rpxe9g0028</password><email>1c527432-ed3d-4059-95d5-a351ff50ea10@localhost</email></query></iq>

2019-11-20 18:37:02 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b3ffc7a1}

2019-11-20 18:37:02 | user :: null << <iq id="7Qv18HGMZ5cSR5EADHskKYp" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-20 18:37:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@60cdcc7d}

2019-11-20 18:37:02 | [Mutex] received everything.

2019-11-20 18:37:02 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-20 18:37:02 | 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;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6e565117, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@369afad5]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4f44a463}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@4b7b2953}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@e79ae58}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@553067ee}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:02 PST 2019}}}}

2019-11-20 18:37:02 | 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;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6e565117, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@369afad5]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4f44a463}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@4b7b2953}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@e79ae58}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@553067ee}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:02 PST 2019}}}}

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@160cee3

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2d8b823c

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@25104022

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

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2b30ded9

2019-11-20 18:37:02 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2c201a8a

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JweGU5ZzAwMjgscj1IeXZSbGFyQ0xhWjhFVVc3b05leQ==</auth>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IeXZSbGFyQ0xhWjhFVVc3b05leW85clluVWRVdU1OR2t5dWhtMXV1LHM9R01VRW5xOTQ5bk8yRHc9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SHl2UmxhckNMYVo4RVVXN29OZXlvOXJZblVkVXVNTkdreXVobTF1dSxwPUV5czBFREhHTFhTOWF4S2FxWm10MmQ3L25YdnVNS28zaGFJNHFPK3kzek09</response>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj04enIrNmtwZFk4bGpHczdFMUtJUU9uVjQvelFrckFEdnkxYWx6dnVEa3ZnPQ==</success>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@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 ver="8SAx7sxxLI3422mjAeBbH2oWxJg=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost >> <iq xmlns="jabber:client" id="l10pSaqk7n1bEnKGCvfGFnQ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost << <iq id="l10pSaqk7n1bEnKGCvfGFnQ" to="user_rpxe9g0028@localhost/993927746-tigase-20" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_rpxe9g0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="LBISR5EADHskKYpXbviFkQW" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost/993927746-tigase-20 << <iq id="LBISR5EADHskKYpXbviFkQW" to="user_rpxe9g0028@localhost/993927746-tigase-20" type="result" xmlns="jabber:client"/>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="ZRs1kJs6sbBo5dwteSbtYqX" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost/993927746-tigase-20 << <enabled max="60" id="d81d6696-03a3-4d7b-b845-2849534b5e4c" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost/993927746-tigase-20 >> <iq id="tSt3oRICufJEBfABuodx6Gt" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost/993927746-tigase-20 << <iq id="tSt3oRICufJEBfABuodx6Gt" to="user_rpxe9g0028@localhost/993927746-tigase-20" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 18:37:02 | Disconnecting

2019-11-20 18:37:02 | [Mutex] notify: [disconnected]

2019-11-20 18:37:02 | [Mutex] received everything.

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

2019-11-20 18:37:02 | [Mutex] waiting for: [event]

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

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JweGU5ZzAwMjgscj1tN0o5UnpoYVRNRzkwNjkwTUg1Zg==</auth>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tN0o5UnpoYVRNRzkwNjkwTUg1Zm9VTDNDc2NMT1V4b21OcHJzYkhXLHM9R01VRW5xOTQ5bk8yRHc9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bTdKOVJ6aGFUTUc5MDY5ME1INWZvVUwzQ3NjTE9VeG9tTnByc2JIVyxwPVcvK1dRWlgrWC9aa2lNaDlld2l3a0NWMjVZblVsZEx2bXo3N3NyODg1TVU9</response>

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-20 18:37:02 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:02 | [Mutex] received everything.

2019-11-20 18:37:02 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:37:02 | [Mutex] waiting for: [event]

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

2019-11-20 18:37:02 | user :: user_rpxe9g0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JweGU5ZzAwMjgscj1PVnBGY1FXVnJMZ2lzSVhOcGpldg==</auth>

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PVnBGY1FXVnJMZ2lzSVhOcGpldlNXak1TN1ExUHNVZGxxdkxIY3JaLHM9R01VRW5xOTQ5bk8yRHc9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T1ZwRmNRV1ZyTGdpc0lYTnBqZXZTV2pNUzdRMVBzVWRscXZMSGNyWixwPXhLL3U0MERUUWplVmt1c2FtbmNGTmxSNzlhd01FRklvanRiQjZ1amVSZjA9</response>

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

2019-11-20 18:37:03 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:03 | [Mutex] received everything.

2019-11-20 18:37:03 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:37:03 | [Mutex] waiting for: [event]

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

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JweGU5ZzAwMjgscj1ZOGRWRWxybzZkc2ZraVI5czdpNA==</auth>

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZOGRWRWxybzZkc2ZraVI5czdpNHZ3T3hSUFJUd1F4QjhFVEpxaTM0LHM9R01VRW5xOTQ5bk8yRHc9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WThkVkVscm82ZHNma2lSOXM3aTR2d094UlBSVHdReEI4RVRKcWkzNCxwPXZmdURFMzk3TmlhbXVTbGFrNDdkdC9NNWhQNlovSDM4TXRwaG9iWXdSWjQ9</response>

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

2019-11-20 18:37:03 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:03 | [Mutex] notify: [event, disconnected]

2019-11-20 18:37:03 | [Mutex] received everything.

2019-11-20 18:37:03 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:37:03 | [Mutex] waiting for: [event]

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

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JweGU5ZzAwMjgscj1jdmtYcHdCaWNVa0ltNjliYnZOQQ==</auth>

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jdmtYcHdCaWNVa0ltNjliYnZOQWxYOHBMWm9SSjdPbUZ5YnJiVEU3LHM9R01VRW5xOTQ5bk8yRHc9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y3ZrWHB3QmljVWtJbTY5YmJ2TkFsWDhwTFpvUko3T21GeWJyYlRFNyxwPU52a0hGcTE5LzFKcDNjOEpuNnhxenA1eGN0T3paLzR3WGlQaUdYbWpSY2c9</response>

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

2019-11-20 18:37:03 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:03 | [Mutex] received everything.

2019-11-20 18:37:03 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JweGU5ZzAwMjgscj1nMGZveHh5N2ZNdXVIZTZYbkdDcw==</auth>

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nMGZveHh5N2ZNdXVIZTZYbkdDc2JDNlZOdXlDMHJkVG84UHFUQ0w5LHM9R01VRW5xOTQ5bk8yRHc9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:03 | user :: user_rpxe9g0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZzBmb3h4eTdmTXV1SGU2WG5HQ3NiQzZWTnV5QzByZFRvOFBxVENMOSxwPW9HNkJIVU9CY0o0eGM5QzZDZTk2L0F2MVhmRVdWeFo0aG1xanBVUERqSjQ9</response>

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

2019-11-20 18:37:05 | [Mutex] waiting for: [user]

2019-11-20 18:37:05 | [Mutex] received everything.

2019-11-20 18:37:05 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-20 18:37:05 |

2019-11-20 18:37:05 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-20 18:37:05 | ------------------------------------

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5dd3da74

2019-11-20 18:37:05 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29586656}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@53143fbe}, 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@572bb104}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@12293585}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@516a4dce}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:05 PST 2019}}}}

2019-11-20 18:37:05 | [Mutex] waiting for: [registration]

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@23716192

2019-11-20 18:37:05 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@53143fbe}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@572bb104}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@12293585}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@516a4dce}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:05 PST 2019}}}}

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@29d84769

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

2019-11-20 18:37:05 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7206caca}

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

2019-11-20 18:37:05 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-20 18:37:05 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7101ed79

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@59547f3a

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

2019-11-20 18:37:05 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@32dc8876}

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

2019-11-20 18:37:05 | user :: null >> <iq to="localhost" id="xEHymZdCx7k5sk5hAEpbQYp" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-20 18:37:05 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@71f05b54}

2019-11-20 18:37:05 | user :: null << <iq id="xEHymZdCx7k5sk5hAEpbQYp" type="result" 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-20 18:37:05 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7648547d}

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@8dc15e8

2019-11-20 18:37:05 | user :: null >> <iq to="localhost" id="yRiOT1eLzeT4yxbogDDKM1t" type="set"><query xmlns="jabber:iq:register"><username>user_cdykjw0029</username><password>user_cdykjw0029</password><email>94958637-bf9e-488b-8ba7-5f88e2dd4c1f@localhost</email></query></iq>

2019-11-20 18:37:05 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d167a449}

2019-11-20 18:37:05 | user :: null << <iq id="yRiOT1eLzeT4yxbogDDKM1t" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-20 18:37:05 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@720b0666}

2019-11-20 18:37:05 | [Mutex] received everything.

2019-11-20 18:37:05 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-20 18:37: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;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7206caca, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@32dc8876]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@53143fbe}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@572bb104}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@12293585}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@516a4dce}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:05 PST 2019}}}}

2019-11-20 18:37: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;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7206caca, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@32dc8876]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@53143fbe}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@572bb104}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@12293585}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@516a4dce}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:05 PST 2019}}}}

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@24c2bf69

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@101dfc30

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7806c88e

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5294d9de

2019-11-20 18:37:05 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@631c1d12

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

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

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

2019-11-20 18:37:05 | user :: user_cdykjw0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NkeWtqdzAwMjkscj1jcXk2azFpaVd6c0w1VzlUc2pDOA==</auth>

2019-11-20 18:37:05 | user :: user_cdykjw0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jcXk2azFpaVd6c0w1VzlUc2pDOFBuV0dGV2Y4ekNqVnNleURwV3M0LHM9Z0x4QmZtS1NsZmxDelE9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:05 | user :: user_cdykjw0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y3F5NmsxaWlXenNMNVc5VHNqQzhQbldHRldmOHpDalZzZXlEcFdzNCxwPXNoSm1nV0JJU0s4NlIySUpQVkdxaWtac3VRcXY3WVF4Mk9EeW1WaFJSaG89</response>

2019-11-20 18:37:05 | user :: user_cdykjw0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj12QzJtTHNmQnlBY2JxYk5rWE5jS1k4QmhQaDJXNmU0Qks4TU4vaVpwS0trPQ==</success>

2019-11-20 18:37:06 | user :: user_cdykjw0029@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 ver="8SAx7sxxLI3422mjAeBbH2oWxJg=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <iq xmlns="jabber:client" id="MabrfYeVhCEogZ7v9AfuaAr" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost << <iq id="MabrfYeVhCEogZ7v9AfuaAr" to="user_cdykjw0029@localhost/993927746-tigase-21" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_cdykjw0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="ra9p5jUTMKKLLIJv6Dywt38" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost/993927746-tigase-21 << <iq id="ra9p5jUTMKKLLIJv6Dywt38" to="user_cdykjw0029@localhost/993927746-tigase-21" type="result" xmlns="jabber:client"/>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="G94ocPLyAhVkWl7i06GPNRR" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost/993927746-tigase-21 << <enabled max="60" id="358caa47-4793-4c2f-8edd-bc48e309e7b8" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost/993927746-tigase-21 >> <iq id="1JMIGDvcHrYn2upVSezvugZ" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost/993927746-tigase-21 << <iq id="1JMIGDvcHrYn2upVSezvugZ" to="user_cdykjw0029@localhost/993927746-tigase-21" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 18:37:06 | Disconnecting

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

2019-11-20 18:37:06 | [Mutex] notify: [disconnected]

2019-11-20 18:37:06 | [Mutex] received everything.

2019-11-20 18:37:06 | [Mutex] waiting for: [event]

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

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

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

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2NkeWtqdzAwMjkscj1aVnU3cHlPWUY0aFZTUWxLdHhaVA==</auth>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aVnU3cHlPWUY0aFZTUWxLdHhaVHVQd2U0dUFIYlhqRWtKTWlOVVhPLHM9alY3VEpKTlpEbVFwRGc9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WlZ1N3B5T1lGNGhWU1FsS3R4WlR1UHdlNHVBSGJYakVrSk1pTlVYTyxwPU9EYlNHN0tTMGFvRXJseEJJRHQvOGM4OHRyOD0=</response>

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

2019-11-20 18:37:06 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:06 | [Mutex] received everything.

2019-11-20 18:37:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:37:06 | [Mutex] waiting for: [event]

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

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

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

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2NkeWtqdzAwMjkscj1pd2YybmJCS2hJUU5IcHBCRlB6cg==</auth>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pd2YybmJCS2hJUU5IcHBCRlB6cmdjZTZwRUczVmtDYlNyQVV6SHdlLHM9alY3VEpKTlpEbVFwRGc9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aXdmMm5iQktoSVFOSHBwQkZQenJnY2U2cEVHM1ZrQ2JTckFVekh3ZSxwPUhuejB1SVAwSm1DVUxaTzc1eC9YekMwQlkrcz0=</response>

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

2019-11-20 18:37:06 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:06 | [Mutex] received everything.

2019-11-20 18:37:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:37:06 | [Mutex] waiting for: [event]

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

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

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

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NkeWtqdzAwMjkscj1EUGJ5dXFnNVlnbjF4SGZ1SGhkNw==</auth>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EUGJ5dXFnNVlnbjF4SGZ1SGhkN1pRZVJuWVlubWhKOEZMUXhBU2RXLHM9Z0x4QmZtS1NsZmxDelE9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RFBieXVxZzVZZ24xeEhmdUhoZDdaUWVSbllZbm1oSjhGTFF4QVNkVyxwPUxVYjlEclk1eTg4V3h0STVKOHN1K1ZKaGZiNTRuWkhiYTNWOW41S000QlE9</response>

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

2019-11-20 18:37:06 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:06 | [Mutex] received everything.

2019-11-20 18:37:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:37:06 | [Mutex] waiting for: [event]

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

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

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

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2NkeWtqdzAwMjkscj1DRmxXZVVLZ3BXcmd0NzBUY25hUA==</auth>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DRmxXZVVLZ3BXcmd0NzBUY25hUHZnNkYwVm56N2owcWJlSWVEeUJJLHM9alY3VEpKTlpEbVFwRGc9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q0ZsV2VVS2dwV3JndDcwVGNuYVB2ZzZGMFZuejdqMHFiZUllRHlCSSxwPWJIME5IMWpoWlFLeDJYZkluL2t0TThvSCtIbz0=</response>

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

2019-11-20 18:37:06 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:06 | [Mutex] received everything.

2019-11-20 18:37:06 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NkeWtqdzAwMjkscj01ZHYweHNmTzh0SVRXT2NQWnVQaQ==</auth>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01ZHYweHNmTzh0SVRXT2NQWnVQaTVrRFkwTTNRVmlyTm5IRGdtMHRsLHM9Z0x4QmZtS1NsZmxDelE9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:06 | user :: user_cdykjw0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NWR2MHhzZk84dElUV09jUFp1UGk1a0RZME0zUVZpck5uSERnbTB0bCxwPXQwbDFuck5pa0tCUXdicCtyUm5QQXJuL0diZ1RNYy9kQStDQlhiSGR5Ykk9</response>

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

2019-11-20 18:37:08 | [Mutex] waiting for: [user]

2019-11-20 18:37:08 | [Mutex] received everything.

2019-11-20 18:37:08 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-20 18:37:08 |

2019-11-20 18:37:08 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-20 18:37:08 | ------------------------------------

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1447f551

2019-11-20 18:37:08 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29586656}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a8019a9}, 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@1ebf9e21}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5bbd1392}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@70fb88c9}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:08 PST 2019}}}}

2019-11-20 18:37:08 | [Mutex] waiting for: [registration]

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6aac8a2e

2019-11-20 18:37:08 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a8019a9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@1ebf9e21}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5bbd1392}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@70fb88c9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:08 PST 2019}}}}

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@8004fcc

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

2019-11-20 18:37:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b92ecdd}

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

2019-11-20 18:37:08 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-20 18:37:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@170386a6

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@19709392

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

2019-11-20 18:37:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1304c15f}

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

2019-11-20 18:37:08 | user :: null >> <iq to="localhost" id="32Br7q9lMZgWjJus1piSdRM" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-20 18:37:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@30dc7e29}

2019-11-20 18:37:08 | user :: null << <iq id="32Br7q9lMZgWjJus1piSdRM" type="result" 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-20 18:37:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3fdc33e6}

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3461b40d

2019-11-20 18:37:08 | user :: null >> <iq to="localhost" id="ae9ywt38KBzCwvrWiGQ9r9r" type="set"><query xmlns="jabber:iq:register"><username>user_yoibku0030</username><password>user_yoibku0030</password><email>19c024da-af09-4c10-9c2c-c1b224553fc9@localhost</email></query></iq>

2019-11-20 18:37:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@589c939}

2019-11-20 18:37:08 | user :: null << <iq id="ae9ywt38KBzCwvrWiGQ9r9r" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-20 18:37:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@29104d10}

2019-11-20 18:37:08 | [Mutex] received everything.

2019-11-20 18:37:08 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-20 18:37:08 | 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;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b92ecdd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1304c15f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a8019a9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@1ebf9e21}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5bbd1392}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@70fb88c9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:08 PST 2019}}}}

2019-11-20 18:37:08 | 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;@29586656}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b92ecdd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1304c15f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a8019a9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@68656c6d}, 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@1ebf9e21}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5bbd1392}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@70fb88c9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 20 18:37:08 PST 2019}}}}

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1c2b7f54

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@42b63c34

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7bce39b3

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

2019-11-20 18:37:08 | user :: user_yoibku0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@501d8317

2019-11-20 18:37:08 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@178b979f

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

2019-11-20 18:37:08 | user :: user_yoibku0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lvaWJrdTAwMzAscj1ETzIxSWlyOVMybkZ1Z3BLanB4eQ==</auth>

2019-11-20 18:37:08 | user :: user_yoibku0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ETzIxSWlyOVMybkZ1Z3BLanB4eUZoWVRvN1ByUVBPcEFiR0VjVzRYLHM9N2taNTNKWUp4VmFoUVE9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RE8yMUlpcjlTMm5GdWdwS2pweHlGaFlUbzdQclFQT3BBYkdFY1c0WCxwPXpndWdZSmdaTmZTT2xMNHFhU0Y0Y2JvRWM0UkxQTGc2UjVHRldXWnc1SUE9</response>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1CVDgzQWswckZFM2xCc1dzU0F4UTVGZkxLVklmK1d4RlBVWm5JVm93QTZJPQ==</success>

2019-11-20 18:37:09 | user :: user_yoibku0030@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 ver="8SAx7sxxLI3422mjAeBbH2oWxJg=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <iq xmlns="jabber:client" id="1ORS0hNMRLCFCEJzaOJP8yz" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost << <iq id="1ORS0hNMRLCFCEJzaOJP8yz" to="user_yoibku0030@localhost/993927746-tigase-22" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_yoibku0030@localhost/993927746-tigase-22</jid></bind></iq>

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

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost/993927746-tigase-22 << <iq id="jjkUhZ2u4CHxlPWXU0gNPQZ" to="user_yoibku0030@localhost/993927746-tigase-22" type="result" xmlns="jabber:client"/>

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

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

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost/993927746-tigase-22 << <enabled max="60" id="f4f5faaf-252f-46dd-b953-047daa42726d" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost/993927746-tigase-22 >> <iq id="k9MZpSaqk7n1bEnKGCvfGFn" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost/993927746-tigase-22 << <iq id="k9MZpSaqk7n1bEnKGCvfGFn" to="user_yoibku0030@localhost/993927746-tigase-22" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 18:37:09 | Disconnecting

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

2019-11-20 18:37:09 | [Mutex] notify: [disconnected]

2019-11-20 18:37:09 | [Mutex] received everything.

2019-11-20 18:37:09 | [Mutex] waiting for: [event]

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

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

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

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lvaWJrdTAwMzAscj1leG41RHMwbm5aMzREOGs1QVVWcA==</auth>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1leG41RHMwbm5aMzREOGs1QVVWcFF3VGRIbVYycnZKSmtxRmJpQzI4LHM9N2taNTNKWUp4VmFoUVE9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZXhuNURzMG5uWjM0RDhrNUFVVnBRd1RkSG1WMnJ2SkprcUZiaUMyOCxwPWxrc0ZMNTFITnZZK2pnT2psbWF0eE1raFYwVDBJVEg0bWo3ZEJyaFlBMmM9</response>

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

2019-11-20 18:37:09 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:09 | [Mutex] received everything.

2019-11-20 18:37:09 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:37:09 | [Mutex] waiting for: [event]

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

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

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

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lvaWJrdTAwMzAscj02VFkyTDZNYVZWSEpWUGwxbWFJaw==</auth>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02VFkyTDZNYVZWSEpWUGwxbWFJa0tnYlMyc2RaODJ1SlFZakxNeDZOLHM9N2taNTNKWUp4VmFoUVE9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NlRZMkw2TWFWVkhKVlBsMW1hSWtLZ2JTMnNkWjgydUpRWWpMTXg2TixwPXpQQUptMU9JQkhaVnNtcW1uZE5vQkJSUmpFaEpkamFHWHFMYnpYNGhPcmc9</response>

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

2019-11-20 18:37:09 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:09 | [Mutex] received everything.

2019-11-20 18:37:09 | [Mutex] isItemNotified: authFailed :: true

2019-11-20 18:37:09 | [Mutex] waiting for: [event]

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

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

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

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lvaWJrdTAwMzAscj1JaGZ3bkJJeVlHVGtoQzhBdW44Rg==</auth>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JaGZ3bkJJeVlHVGtoQzhBdW44RjluZmVrS2NMSE43bHVtdW16OXFCLHM9N2taNTNKWUp4VmFoUVE9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SWhmd25CSXlZR1RraEM4QXVuOEY5bmZla0tjTEhON2x1bXVtejlxQixwPVl3a01nTDQvbTd1bzZxZXBMRDBsTDBaNVhsZm94bG9EajdlaHhQN3FhejQ9</response>

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

2019-11-20 18:37:09 | [Mutex] notify: [event, authFailed]

2019-11-20 18:37:09 | [Mutex] received everything.

2019-11-20 18:37:09 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lvaWJrdTAwMzAscj1XMkVBUGEwTHZmUGhEYnU2QTdkOA==</auth>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XMkVBUGEwTHZmUGhEYnU2QTdkOExKRm5rOUJmZVU2UGllOGVLTERxLHM9N2taNTNKWUp4VmFoUVE9PSxpPTQwOTY=</challenge>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VzJFQVBhMEx2ZlBoRGJ1NkE3ZDhMSkZuazlCZmVVNlBpZThlS0xEcSxwPWVVTUlPWExXZElIUXFxdDJ3ZUljQXZKNFpTQVdYWHRhdzhyRHV5a1IvY009</response>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1pVDJ3a2FrT2FTWE8rV09UbngxL3dpcjJON3VFY3JPL3lPeHFLb2pHUHBFPQ==</success>

2019-11-20 18:37:09 | user :: user_yoibku0030@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 ver="8SAx7sxxLI3422mjAeBbH2oWxJg=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost >> <iq xmlns="jabber:client" id="C4vhBi1k4zfww9FOUhZ2u4C" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="7cRJyxm8Hv2ydN4qj3aKAEL" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost/993927746-tigase-23 << <iq id="7cRJyxm8Hv2ydN4qj3aKAEL" to="user_yoibku0030@localhost/993927746-tigase-23" type="result" xmlns="jabber:client"/>

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

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

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost/993927746-tigase-23 << <enabled max="60" id="a0ae4e57-5701-404c-92c1-57564e60f6d2" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost/993927746-tigase-23 >> <iq id="cleRPGQNXo4BDk4eWlPVZgB" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-20 18:37:09 | user :: user_yoibku0030@localhost/993927746-tigase-23 << <iq id="cleRPGQNXo4BDk4eWlPVZgB" to="user_yoibku0030@localhost/993927746-tigase-23" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-20 18:37:09 | Disconnecting

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

2019-11-20 18:37:09 | [Mutex] notify: [disconnected]

2019-11-20 18:37:09 | [Mutex] received everything.

2019-11-20 18:37:11 | [Mutex] waiting for: [user]

2019-11-20 18:37:11 | [Mutex] received everything.

2019-11-20 18:37:11 | [Mutex] isItemNotified: user:ok:true :: true