Brute Force Prevention

2019-11-27 20:09:37 |

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

2019-11-27 20:09:37 | ------------------------------------

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@8610ac3

2019-11-27 20:09:37 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a6f5bf}, 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@29961b3}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@479bff84}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@47acc2a6}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:37 PST 2019}}}}

2019-11-27 20:09:37 | [Mutex] waiting for: [registration]

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7616dce1

2019-11-27 20:09:37 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a6f5bf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@29961b3}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@479bff84}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@47acc2a6}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:37 PST 2019}}}}

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@3fcbbf69

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

2019-11-27 20:09:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@27b400cb}

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

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

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

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6ac4f69

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@469d7a89

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

2019-11-27 20:09:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@24cfb5c4}

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

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

2019-11-27 20:09:37 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@57c96ce2}

2019-11-27 20:09:37 | user :: null << <iq from="localhost" type="result" id="lJsmZnMAaNBhHTUcxxaq7HT" 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-27 20:09:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@23fa5bce}

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@47c99fdf

2019-11-27 20:09:37 | user :: null >> <iq to="localhost" id="tqv3fZ6Aj5gCvtr5Cnbqk9l" type="set"><query xmlns="jabber:iq:register"><username>user_i8ki3s0027</username><password>user_i8ki3s0027</password><email>b140ec3f-f985-41f6-be18-8b38b7146c00@localhost</email></query></iq>

2019-11-27 20:09:37 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a683c5b8}

2019-11-27 20:09:37 | user :: null << <iq from="localhost" type="result" id="tqv3fZ6Aj5gCvtr5Cnbqk9l" xmlns="jabber:client"/>

2019-11-27 20:09:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6a2dec9d}

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

2019-11-27 20:09:37 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 20:09:37 | 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;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@27b400cb, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@24cfb5c4]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a6f5bf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@29961b3}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@479bff84}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@47acc2a6}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:37 PST 2019}}}}

2019-11-27 20:09:37 | 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;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@27b400cb, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@24cfb5c4]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6a6f5bf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@29961b3}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@479bff84}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@47acc2a6}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:37 PST 2019}}}}

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@33150589

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@42401c0e

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@497c54fe

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4cb00048

2019-11-27 20:09:37 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@57927d1a

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

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

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

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

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

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

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

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

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

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

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

2019-11-27 20:09:37 | user :: user_i8ki3s0027@localhost/993927746-tigase-19 << <iq type="result" id="VtAak7fzh3eQP7kKLZt9KDH" xmlns="jabber:client" to="user_i8ki3s0027@localhost/993927746-tigase-19"/>

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

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

2019-11-27 20:09:37 | user :: user_i8ki3s0027@localhost/993927746-tigase-19 << <enabled resume="true" id="5c43c410-3740-42a4-ae84-ce1d08f34cea" xmlns="urn:xmpp:sm:3" max="60" location="d4270859fb27"/>

2019-11-27 20:09:37 | user :: user_i8ki3s0027@localhost/993927746-tigase-19 >> <iq id="exISfxbJEDKLVSMyz9nThGK" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 20:09:37 | user :: user_i8ki3s0027@localhost/993927746-tigase-19 << <iq from="localhost" type="result" id="izQ1eN4pdsWSdrX3Bk2dTSQ" xmlns="jabber:client" to="user_i8ki3s0027@localhost/993927746-tigase-19"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="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:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-27 20:09:37 | user :: user_i8ki3s0027@localhost/993927746-tigase-19 << <iq type="result" id="exISfxbJEDKLVSMyz9nThGK" xmlns="jabber:client" to="user_i8ki3s0027@localhost/993927746-tigase-19"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1abmtCb294N1FPUk1UU1hlOHRjaA==</auth>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1abmtCb294N1FPUk1UU1hlOHRjaHdjRU5HR1RvY1dFSllaY1RtSFRMLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Wm5rQm9veDdRT1JNVFNYZTh0Y2h3Y0VOR0dUb2NXRUpZWmNUbUhUTCxwPVh1ckY1M1FNdERlbGFNMmUvYXF4WUFGTlhyY1BmeU1iR0VwektWZGJGWkk9</response>

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

2019-11-27 20:09:38 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:38 | [Mutex] notify: [event, disconnected]

2019-11-27 20:09:38 | [Mutex] received everything.

2019-11-27 20:09:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:38 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj05V3RuNDFYWmxjTFBzaHVPTk8zZQ==</auth>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05V3RuNDFYWmxjTFBzaHVPTk8zZVE4NHR6VDEwaktQczdoaUtzZ3R4LHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OVd0bjQxWFpsY0xQc2h1T05PM2VRODR0elQxMGpLUHM3aGlLc2d0eCxwPThoZjdRNm1rdzBDWkZFTlh5OFBmdW9mS0hBRzBjZDRJZ0c0M2psRUV5aEU9</response>

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

2019-11-27 20:09:38 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:38 | [Mutex] received everything.

2019-11-27 20:09:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:38 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1LcTVYaDhjVHlGTDBIS3JrakRNQw==</auth>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LcTVYaDhjVHlGTDBIS3JrakRNQ3RqekdhdEQzTFZTaFNzZ2pJeG11LHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S3E1WGg4Y1R5RkwwSEtya2pETUN0anpHYXREM0xWU2hTc2dqSXhtdSxwPU8zS0VEZ2p0N3FLTnMrOUxTM0VrSEEva0ZTU25WSVRsOXVqUHVpTG95K0E9</response>

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

2019-11-27 20:09:38 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:38 | [Mutex] received everything.

2019-11-27 20:09:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:38 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj11NWFJcnVkWXhSaW1PalJOc294cQ==</auth>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11NWFJcnVkWXhSaW1PalJOc294cVBEeTJaNzdmeHI0aXk4SEd0RTJTLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dTVhSXJ1ZFl4UmltT2pSTnNveHFQRHkyWjc3ZnhyNGl5OEhHdEUyUyxwPVpWSytWMzdUTFlVY1l1RTNWK0p3VWVsRDd4OXZCZE5yallHZ2w5eEhUb009</response>

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

2019-11-27 20:09:38 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:38 | [Mutex] received everything.

2019-11-27 20:09:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:38 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj13ZWJialpNdVVob2Z4WGFnZld4MQ==</auth>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13ZWJialpNdVVob2Z4WGFnZld4MVQxbFZIcTJZMlNwZ3lIQVhUajhiLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d2ViYmpaTXVVaG9meFhhZ2ZXeDFUMWxWSHEyWTJTcGd5SEFYVGo4YixwPXRQOG4xT1lOTHZaRWN5QU15WHRTS1BvbklxMXgzTFduQ0VibG5WK2pUU3c9</response>

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

2019-11-27 20:09:38 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:38 | [Mutex] received everything.

2019-11-27 20:09:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:38 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1TTzZBU1VzUm40dDVFenFoU2l3Wg==</auth>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TTzZBU1VzUm40dDVFenFoU2l3WjNSWm1PblRpYWRYWG5TeDQyZEFHLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U082QVNVc1JuNHQ1RXpxaFNpd1ozUlptT25UaWFkWFhuU3g0MmRBRyxwPWZhTkcvNVpRbVA3RHdPcUtDWDh5WS9TUkxaVUd2WW5MUDQ5MVloWG96YXM9</response>

2019-11-27 20:09:38 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:38 | [Mutex] received everything.

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

2019-11-27 20:09:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:38 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1YQ1UwVEJzcTA5Vnk4TzhXeFpBaw==</auth>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YQ1UwVEJzcTA5Vnk4TzhXeFpBa1Y5SHR5SWdRVG0yQXB5MFgxR0VnLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WENVMFRCc3EwOVZ5OE84V3haQWtWOUh0eUlnUVRtMkFweTBYMUdFZyxwPWh0R3ZZTzRhNXY0V1lPaER4OEJjMndzUTZnYk5wek1rc0EzVG0vSnhvQnc9</response>

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

2019-11-27 20:09:38 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:38 | [Mutex] received everything.

2019-11-27 20:09:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:38 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj01cTNwbzZDUzRFeHNCNlFKbnk1Mg==</auth>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01cTNwbzZDUzRFeHNCNlFKbnk1MjZiREs5ck1vczdTZ2F2TDIwZWNXLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NXEzcG82Q1M0RXhzQjZRSm55NTI2YkRLOXJNb3M3U2dhdkwyMGVjVyxwPURQWjRwUDVoNlpaYUt6c0kvT0RrRlJYenlIbTNtV2NrckFPb055Nm9BQjA9</response>

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

2019-11-27 20:09:38 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:38 | [Mutex] received everything.

2019-11-27 20:09:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:38 | [Mutex] notify: [event, disconnected]

2019-11-27 20:09:38 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1IaEp6UUpsZlE0Q2pKa2Z5R055Ng==</auth>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IaEp6UUpsZlE0Q2pKa2Z5R055NnVlRGRqaG1yY2djb3g2WDNDVzl1LHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:38 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SGhKelFKbGZRNENqSmtmeUdOeTZ1ZURkamhtcmNnY294NlgzQ1c5dSxwPTNNbEFsUklnR1BFcm50Nld0azVCYWJ3VnJZajQwdVpWVlJ1U3dLSXgwNXM9</response>

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

2019-11-27 20:09:39 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:39 | [Mutex] notify: [event, disconnected]

2019-11-27 20:09:39 | [Mutex] received everything.

2019-11-27 20:09:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:39 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj13T21YWWRqcm9LVllDVEx2OWw4UA==</auth>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13T21YWWRqcm9LVllDVEx2OWw4UDBOSnBzTXZTcThRY2xtRTZwSlhwLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d09tWFlkanJvS1ZZQ1RMdjlsOFAwTkpwc012U3E4UWNsbUU2cEpYcCxwPXg4R3dtdnZmVDR4VjdTNEFEWnFHa0dZRzI4Vzh2NFp0emc3eFgydERwRHc9</response>

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

2019-11-27 20:09:39 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:39 | [Mutex] received everything.

2019-11-27 20:09:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:39 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj12VmdHdlNlYm5xbHdoNlBKdFdhNA==</auth>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12VmdHdlNlYm5xbHdoNlBKdFdhNGdzemRIMzFrWDJ1dVBwcnlmd2kyLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dlZnR3ZTZWJucWx3aDZQSnRXYTRnc3pkSDMxa1gydXVQcHJ5ZndpMixwPXpVYUlDNTRHUGdSZkJGeUo3cUhWZmQrWjZlZStTRWc3dVFlOFoxSzlIWHM9</response>

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

2019-11-27 20:09:39 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:39 | [Mutex] notify: [event, disconnected]

2019-11-27 20:09:39 | [Mutex] received everything.

2019-11-27 20:09:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:39 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1seGRvNks5SDBWcFhkcU01bnlFOQ==</auth>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1seGRvNks5SDBWcFhkcU01bnlFOW0yUTZuTmo0cWdvcEVoWUF3ZktsLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bHhkbzZLOUgwVnBYZHFNNW55RTltMlE2bk5qNHFnb3BFaFlBd2ZLbCxwPUZaaHZQeFFiM0UwcnYzNC93TVgzRnpMQjlrY0s0aDBTcCtGL0tDTmxWaTg9</response>

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

2019-11-27 20:09:39 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:39 | [Mutex] received everything.

2019-11-27 20:09:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:39 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1CdnZwNEVxaE9EOVJMdXZMQjhUTQ==</auth>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CdnZwNEVxaE9EOVJMdXZMQjhUTUdHbElVYnV0TjdjYjRYU1JuWVJxLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QnZ2cDRFcWhPRDlSTHV2TEI4VE1HR2xJVWJ1dE43Y2I0WFNSbllScSxwPUNIUXFMdnBWTkxtZDBFc004SVBHUUdaNTc5a2s1ek9MQ3l2YndtYmpJVUk9</response>

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

2019-11-27 20:09:39 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:39 | [Mutex] received everything.

2019-11-27 20:09:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:39 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1xWk9jYTdrdFdyVHhSRU9pMGcwYw==</auth>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xWk9jYTdrdFdyVHhSRU9pMGcwY3VvRUxvcVZycGhJT1NmQllHOFlsLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cVpPY2E3a3RXclR4UkVPaTBnMGN1b0VMb3FWcnBoSU9TZkJZRzhZbCxwPStzcGd2MFMwbGxYNEdYTW1BQ2pIaHlGeHNXY3NOLytFWjZWUStNV0pVSXc9</response>

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

2019-11-27 20:09:39 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:39 | [Mutex] received everything.

2019-11-27 20:09:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:39 | [Mutex] notify: [event, disconnected]

2019-11-27 20:09:39 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1tVjdtUjJKRnA5VG1KUG9kQ1VuTg==</auth>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tVjdtUjJKRnA5VG1KUG9kQ1VuTlppZXFTQkQwTm1UMVlkR0UyQmdKLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bVY3bVIySkZwOVRtSlBvZENVbk5aaWVxU0JEME5tVDFZZEdFMkJnSixwPVlqcFoyYW8xZE5ueWtGSGRQY2JXYmI1cndMMjV4T2wxYjRLYU05eFJzWTQ9</response>

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

2019-11-27 20:09:39 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:39 | [Mutex] received everything.

2019-11-27 20:09:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:39 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1CZnJRNHYzTlFnUUpnMjFmYTJ1ZA==</auth>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CZnJRNHYzTlFnUUpnMjFmYTJ1ZFp1OWI0V3kzbEFWMWRCZjdhOEZPLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QmZyUTR2M05RZ1FKZzIxZmEydWRadTliNFd5M2xBVjFkQmY3YThGTyxwPTlsZE15NFdOb2hBSVh4YjArRFhDV3pDRDhXalZXR2RXU3hlRzBtUVZzSzQ9</response>

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

2019-11-27 20:09:39 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:39 | [Mutex] received everything.

2019-11-27 20:09:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:39 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1GRFFWSUU5TDhFcE9tT3d1YXdVcg==</auth>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GRFFWSUU5TDhFcE9tT3d1YXdVcjJ2QjlrWDhla3VVMmJGUWlFdFlrLHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:39 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RkRRVklFOUw4RXBPbU93dWF3VXIydkI5a1g4ZWt1VTJiRlFpRXRZayxwPWpxdFpVSlVGbFhNYzJqSjZnM3lXdlJUdHk2d1RXcEt4UzhIOFNLblo3eXM9</response>

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

2019-11-27 20:09:39 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:39 | [Mutex] received everything.

2019-11-27 20:09:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:40 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:40 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1DUWhzWldUbEM5bUpkZHpIanhjQg==</auth>

2019-11-27 20:09:40 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DUWhzWldUbEM5bUpkZHpIanhjQnk4VmVvalY0Q1lLaEl3VDlSZ2p1LHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:40 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q1Foc1pXVGxDOW1KZGR6SGp4Y0J5OFZlb2pWNENZS2hJd1Q5UmdqdSxwPUhMdmYzY2ZiSHV0dVVQV1hTM2NWcDFRb3JZTXAvM3lHY1hEMFBhako1ajg9</response>

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

2019-11-27 20:09:40 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:40 | [Mutex] notify: [event, disconnected]

2019-11-27 20:09:40 | [Mutex] received everything.

2019-11-27 20:09:40 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-27 20:09:40 | user :: user_i8ki3s0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2k4a2kzczAwMjcscj1sbnVDb3c4RzFIZTIyc0paUXZkMA==</auth>

2019-11-27 20:09:40 | user :: user_i8ki3s0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sbnVDb3c4RzFIZTIyc0paUXZkMGNLTW1GZUpoa1J2cnlkOTF5OEo4LHM9UWpGZHhSQlgycmk0VVE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:40 | user :: user_i8ki3s0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bG51Q293OEcxSGUyMnNKWlF2ZDBjS01tRmVKaGtSdnJ5ZDkxeThKOCxwPTZTQTBDc1BFMXRQRnhLRTdONTBsRm9rOWEwWjg5bG9PczdRR1NPa05FeEk9</response>

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

2019-11-27 20:09:42 | [Mutex] waiting for: [user]

2019-11-27 20:09:42 | [Mutex] received everything.

2019-11-27 20:09:42 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-27 20:09:42 |

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

2019-11-27 20:09:42 | ------------------------------------

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@58e25d5f

2019-11-27 20:09:42 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5625b833}, 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@521a362f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1718b208}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5dda1d11}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:42 PST 2019}}}}

2019-11-27 20:09:42 | [Mutex] waiting for: [registration]

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2645c2b9

2019-11-27 20:09:42 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5625b833}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@521a362f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1718b208}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5dda1d11}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:42 PST 2019}}}}

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@256d3310

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

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

2019-11-27 20:09:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@77374d47}

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

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

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7a08f425

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@72d0b1d7

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

2019-11-27 20:09:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3e69f92e}

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

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

2019-11-27 20:09:42 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3bac15f1}

2019-11-27 20:09:42 | user :: null << <iq from="localhost" type="result" id="VyFkELx9rnS8phEo3zDtoVh" 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-27 20:09:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7379d6d1}

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@4e6dad47

2019-11-27 20:09:42 | user :: null >> <iq to="localhost" id="M25btjOXo3v26cRJxdVYkN3" type="set"><query xmlns="jabber:iq:register"><username>user_f53azn0028</username><password>user_f53azn0028</password><email>acde10e9-4f48-4a85-aeba-d47670f947ee@localhost</email></query></iq>

2019-11-27 20:09:42 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c20f5644}

2019-11-27 20:09:42 | user :: null << <iq from="localhost" type="result" id="M25btjOXo3v26cRJxdVYkN3" xmlns="jabber:client"/>

2019-11-27 20:09:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@39c4e354}

2019-11-27 20:09:42 | [Mutex] received everything.

2019-11-27 20:09:42 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 20:09:42 | 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;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@77374d47, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3e69f92e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5625b833}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@521a362f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1718b208}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5dda1d11}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:42 PST 2019}}}}

2019-11-27 20:09:42 | 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;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@77374d47, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3e69f92e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5625b833}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@521a362f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1718b208}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5dda1d11}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:42 PST 2019}}}}

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4815cdcb

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@75675546

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@56c3d938

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@48034ef7

2019-11-27 20:09:42 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2e9ea9a9

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

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

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

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1M2F6bjAwMjgscj1aTTZZc2ZSb1BBblVIVkplazFIeA==</auth>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aTTZZc2ZSb1BBblVIVkplazFIeFZqRTNNTlZvM2xZRmwxMlZsRmpiLHM9SnNVTG1zS29jNkRkbUE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Wk02WXNmUm9QQW5VSFZKZWsxSHhWakUzTU5WbzNsWUZsMTJWbEZqYixwPXA5MmxDMDFZK1FEMlN0ZmhsTzlFb3FlMGRSR0NWV05iM3R6TTNBMGZqakk9</response>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0wOURFcG1GZWhzc2ZjeVE5dWFBUVk4bGV1djFpU2h5aklLQ0ZFQ1htdEg0PQ==</success>

2019-11-27 20:09:43 | user :: user_f53azn0028@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <iq xmlns="jabber:client" id="WAHmbnPN5iY5DmOTfZbOLXY" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost/993927746-tigase-20 << <iq type="result" id="DQrj7rkN16GRLDDsfYdPGoM" xmlns="jabber:client" to="user_f53azn0028@localhost/993927746-tigase-20"/>

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

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

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost/993927746-tigase-20 << <enabled resume="true" id="76add70c-b474-451d-a5f8-5d3d08296228" xmlns="urn:xmpp:sm:3" max="60" location="d4270859fb27"/>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost/993927746-tigase-20 >> <iq id="443aq7HTZqZpSeXX1p0laBB" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost/993927746-tigase-20 << <iq type="result" id="443aq7HTZqZpSeXX1p0laBB" xmlns="jabber:client" to="user_f53azn0028@localhost/993927746-tigase-20"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 20:09:43 | Disconnecting

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

2019-11-27 20:09:43 | [Mutex] notify: [disconnected]

2019-11-27 20:09:43 | [Mutex] received everything.

2019-11-27 20:09:43 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1M2F6bjAwMjgscj1OS0RnUG1oeXNCREtMM21QMW4xOQ==</auth>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OS0RnUG1oeXNCREtMM21QMW4xOXlqb0xrT2R6V1lrVmF0R3AwcGllLHM9SnNVTG1zS29jNkRkbUE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TktEZ1BtaHlzQkRLTDNtUDFuMTl5am9Ma09keldZa1ZhdEdwMHBpZSxwPUNaR1VyMXpmUTdBTlpOQkhKdVRzZmdyK1hvMEErdjAvRWE5d25OemVKc2M9</response>

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

2019-11-27 20:09:43 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:43 | [Mutex] notify: [event, disconnected]

2019-11-27 20:09:43 | [Mutex] received everything.

2019-11-27 20:09:43 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:43 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1M2F6bjAwMjgscj1McnpkajZ1UUM5SE55bjJ2SlFaaQ==</auth>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1McnpkajZ1UUM5SE55bjJ2SlFaaWtYeTFMemFqdHZZb2Vqb2c5SHRZLHM9SnNVTG1zS29jNkRkbUE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9THJ6ZGo2dVFDOUhOeW4ydkpRWmlrWHkxTHphanR2WW9lam9nOUh0WSxwPVVMVk8yeDVScmR4SkhBZU4vVHROM3NBa0pnNWNYN2x5akFpSDR6bzErbms9</response>

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

2019-11-27 20:09:43 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:43 | [Mutex] received everything.

2019-11-27 20:09:43 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:43 | [Mutex] notify: [event, disconnected]

2019-11-27 20:09:43 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1M2F6bjAwMjgscj1FRkJRMHB3WTFmWllEeG5LU2FsZg==</auth>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FRkJRMHB3WTFmWllEeG5LU2FsZnp0Q3cxdndOaDBueXNzZWUyOHBMLHM9SnNVTG1zS29jNkRkbUE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RUZCUTBwd1kxZlpZRHhuS1NhbGZ6dEN3MXZ3Tmgwbnlzc2VlMjhwTCxwPWt6elAzelRaREx1M1Z2ZTBOZ2xnaERPVm5KOUdhbXlwemRxSGtiQTZCTkU9</response>

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

2019-11-27 20:09:43 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:43 | [Mutex] received everything.

2019-11-27 20:09:43 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:43 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1M2F6bjAwMjgscj1JeWIzS3RNMml5UVRueWs5NTlJOA==</auth>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JeWIzS3RNMml5UVRueWs5NTlJOGVxdnQ5V3RMVXVkbTJKWE4wZEFjLHM9SnNVTG1zS29jNkRkbUE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SXliM0t0TTJpeVFUbnlrOTU5SThlcXZ0OVd0TFV1ZG0ySlhOMGRBYyxwPWQraktubXlWdkIyRkZUVTVZWFNRaTIxYjhIeFVrb09WUlNieENxNlVUYzA9</response>

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

2019-11-27 20:09:43 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:43 | [Mutex] received everything.

2019-11-27 20:09:43 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1M2F6bjAwMjgscj1qUjNWTE41cDhpSTVRNnNaaTlPdQ==</auth>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qUjNWTE41cDhpSTVRNnNaaTlPdVhheWl1cHJUbVl6UVJVeGlDc3dzLHM9SnNVTG1zS29jNkRkbUE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:43 | user :: user_f53azn0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9alIzVkxONXA4aUk1UTZzWmk5T3VYYXlpdXByVG1ZelFSVXhpQ3N3cyxwPWxtMnpEd2ptMmtwODhaTkVNd1RyVXVmRmxTYzFCZXdhU0lWSUl0VGNkWlE9</response>

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

2019-11-27 20:09:45 | [Mutex] waiting for: [user]

2019-11-27 20:09:45 | [Mutex] received everything.

2019-11-27 20:09:45 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-27 20:09:45 |

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

2019-11-27 20:09:45 | ------------------------------------

2019-11-27 20:09:45 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@23a71a81

2019-11-27 20:09:45 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2d60e085}, 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@295f71f1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6c5deabe}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@773596a6}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:45 PST 2019}}}}

2019-11-27 20:09:45 | [Mutex] waiting for: [registration]

2019-11-27 20:09:45 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5dfb240d

2019-11-27 20:09:45 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2d60e085}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@295f71f1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6c5deabe}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@773596a6}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:45 PST 2019}}}}

2019-11-27 20:09:45 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@f7906ba

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

2019-11-27 20:09:45 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c7215f1}

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

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

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

2019-11-27 20:09:45 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@57a9327f

2019-11-27 20:09:45 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@53f6afcb

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

2019-11-27 20:09:45 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@147d2fd9}

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

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

2019-11-27 20:09:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2cb320bd}

2019-11-27 20:09:46 | user :: null << <iq from="localhost" type="result" id="DVwtr5Cnbqk9lNX6xyn9kGm" 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-27 20:09:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@83c6d3a}

2019-11-27 20:09:46 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@16188c88

2019-11-27 20:09:46 | user :: null >> <iq to="localhost" id="l0JU5zamITNFtr0oVjIwj5F" type="set"><query xmlns="jabber:iq:register"><username>user_s6xr130029</username><password>user_s6xr130029</password><email>4ab4463c-aca2-4eb3-9bdf-c894cd67e5ef@localhost</email></query></iq>

2019-11-27 20:09:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@984552c5}

2019-11-27 20:09:46 | user :: null << <iq from="localhost" type="result" id="l0JU5zamITNFtr0oVjIwj5F" xmlns="jabber:client"/>

2019-11-27 20:09:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@70f6e177}

2019-11-27 20:09:46 | [Mutex] received everything.

2019-11-27 20:09:46 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 20:09:46 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c7215f1, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@147d2fd9]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2d60e085}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@295f71f1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6c5deabe}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@773596a6}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:46 PST 2019}}}}

2019-11-27 20:09:46 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c7215f1, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@147d2fd9]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2d60e085}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@295f71f1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6c5deabe}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@773596a6}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:46 PST 2019}}}}

2019-11-27 20:09:46 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@d081b57

2019-11-27 20:09:46 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6636f271

2019-11-27 20:09:46 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@34184ef3

2019-11-27 20:09:46 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@73a2ec5e

2019-11-27 20:09:46 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3e3d93de

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

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

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

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3M2eHIxMzAwMjkscj1VQTgwV2VPd3RUT1FUajdrencxQg==</auth>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VQTgwV2VPd3RUT1FUajdrencxQnJEZGFRSVo1YW40dTJpb29sRUdULHM9dWJtMHZQb2FpbHBXNUE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VUE4MFdlT3d0VE9RVGo3a3p3MUJyRGRhUUlaNWFuNHUyaW9vbEVHVCxwPVMwd1RYYWZGZ1hSWGo2eWs4bXh6M3Z3Vm9wZ24vbGNRVVZHeW5XUTVjVmc9</response>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj11a0RtU3l5NGpuY2ZQVkVtQ1k4QjViZG85alhscmMxZTNMamlpZHRHZGdFPQ==</success>

2019-11-27 20:09:46 | user :: user_s6xr130029@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <iq xmlns="jabber:client" id="xO7Aj5gCvtr5Cnbqk9lNX6x" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost/993927746-tigase-21 << <iq type="result" id="uMZ5FsiJVWYdThLY5Bg0v3d" xmlns="jabber:client" to="user_s6xr130029@localhost/993927746-tigase-21"/>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost/993927746-tigase-21 >> <iq to="localhost" id="1Q9ErlMEzBHBErjGQbpVdCz" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost/993927746-tigase-21 << <enabled resume="true" id="16969f1f-1448-4140-a067-6a8b2036b7bb" xmlns="urn:xmpp:sm:3" max="60" location="d4270859fb27"/>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost/993927746-tigase-21 >> <iq id="4cbqW9L1fW1t0utZ5xgRcFJ" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost/993927746-tigase-21 << <iq from="localhost" type="result" id="1Q9ErlMEzBHBErjGQbpVdCz" xmlns="jabber:client" to="user_s6xr130029@localhost/993927746-tigase-21"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="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:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost/993927746-tigase-21 << <iq type="result" id="4cbqW9L1fW1t0utZ5xgRcFJ" xmlns="jabber:client" to="user_s6xr130029@localhost/993927746-tigase-21"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 20:09:46 | Disconnecting

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

2019-11-27 20:09:46 | [Mutex] notify: [disconnected]

2019-11-27 20:09:46 | [Mutex] received everything.

2019-11-27 20:09:46 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3M2eHIxMzAwMjkscj1HazRCb2VwRXNadExxaFhTNWtEQQ==</auth>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HazRCb2VwRXNadExxaFhTNWtEQTBMOGhRUFpXbmZhbG9qVmd6OTBoLHM9MU1xUDkxb2NhZWdhSkE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R2s0Qm9lcEVzWnRMcWhYUzVrREEwTDhoUVBaV25mYWxvalZnejkwaCxwPTdkU2pldU5DR0J0UG5HUks3VWlweTJveUV2ST0=</response>

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

2019-11-27 20:09:46 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:46 | [Mutex] received everything.

2019-11-27 20:09:46 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:46 | [Mutex] notify: [event, disconnected]

2019-11-27 20:09:46 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3M2eHIxMzAwMjkscj1BdlN6ZmRsS0xZWktab0lvVEd3Zg==</auth>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BdlN6ZmRsS0xZWktab0lvVEd3ZnBvZlZ4RFBXSWlEQlFHQ3NyNzJhLHM9dWJtMHZQb2FpbHBXNUE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QXZTemZkbEtMWVpLWm9Jb1RHd2Zwb2ZWeERQV0lpREJRR0NzcjcyYSxwPVdEa2VQU2tjYUR6anpJSC9HWWQ4aXRIOXpvc3hEcityT3hzL3BOczRpdWM9</response>

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

2019-11-27 20:09:46 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:46 | [Mutex] received everything.

2019-11-27 20:09:46 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:46 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3M2eHIxMzAwMjkscj1uOThhQWRpOVpON25aSDE1V1IzVg==</auth>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uOThhQWRpOVpON25aSDE1V1IzVkVVSVljVHREUmc2OFZYUnRPb2lhLHM9MU1xUDkxb2NhZWdhSkE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bjk4YUFkaTlaTjduWkgxNVdSM1ZFVUlZY1R0RFJnNjhWWFJ0T29pYSxwPUVUV21Ba2RiL0t0dU9FNEQzRkF4VGNBLzRDcz0=</response>

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

2019-11-27 20:09:46 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:46 | [Mutex] received everything.

2019-11-27 20:09:46 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:46 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfczZ4cjEzMDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-27 20:09:46 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:46 | [Mutex] received everything.

2019-11-27 20:09:46 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3M2eHIxMzAwMjkscj0yTmttbUNXTTRSamJxOEN5S3hxTA==</auth>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yTmttbUNXTTRSamJxOEN5S3hxTExzalVwUEFXZmlkOVdRQ2JrOHV2LHM9dWJtMHZQb2FpbHBXNUE9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:46 | user :: user_s6xr130029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Mk5rbW1DV000UmpicThDeUt4cUxMc2pVcFBBV2ZpZDlXUUNiazh1dixwPVR5ck0zOXBDQ0tNOWlwbTlXR3dDVG9vU3VrV2owV0tUSUQ0MFFyeGRVR2c9</response>

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

2019-11-27 20:09:49 | [Mutex] waiting for: [user]

2019-11-27 20:09:49 | [Mutex] received everything.

2019-11-27 20:09:49 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-27 20:09:49 |

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

2019-11-27 20:09:49 | ------------------------------------

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1dcb7360

2019-11-27 20:09:49 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@130c8ea9}, 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@17331810}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@52318492}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1427bdc7}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:49 PST 2019}}}}

2019-11-27 20:09:49 | [Mutex] waiting for: [registration]

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@63a9102c

2019-11-27 20:09:49 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@130c8ea9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@17331810}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@52318492}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1427bdc7}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:49 PST 2019}}}}

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@6c5577d1

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

2019-11-27 20:09:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@321e7bdd}

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

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

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

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1b7e31dc

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@307d7aef

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

2019-11-27 20:09:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@775178ce}

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

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

2019-11-27 20:09:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@380b9b76}

2019-11-27 20:09:49 | user :: null << <iq from="localhost" type="result" id="kYp7IHNCgwv17nfCCndw8xx" 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-27 20:09:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3650256a}

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5cca12ad

2019-11-27 20:09:49 | user :: null >> <iq to="localhost" id="WPWQ9jHxzgUXnQMP7JFMHPI" type="set"><query xmlns="jabber:iq:register"><username>user_cecelr0030</username><password>user_cecelr0030</password><email>087dc519-c819-444f-9601-f0c44791c842@localhost</email></query></iq>

2019-11-27 20:09:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3504788}

2019-11-27 20:09:49 | user :: null << <iq from="localhost" type="result" id="WPWQ9jHxzgUXnQMP7JFMHPI" xmlns="jabber:client"/>

2019-11-27 20:09:49 | [Mutex] received everything.

2019-11-27 20:09:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@73ba1d9}

2019-11-27 20:09:49 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 20:09:49 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@321e7bdd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@775178ce]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@130c8ea9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@17331810}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@52318492}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1427bdc7}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:49 PST 2019}}}}

2019-11-27 20:09:49 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d34d8c4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@321e7bdd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@775178ce]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@130c8ea9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6c09d2ff}, 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@17331810}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@52318492}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1427bdc7}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 20:09:49 PST 2019}}}}

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7b502ef8

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@4c1c2f8d

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@40cf03d9

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1aa04770

2019-11-27 20:09:49 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@607d9d32

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

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

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

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NlY2VscjAwMzAscj1qM2JNWlNkZnNWRjd5dUoxTEpTbg==</auth>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qM2JNWlNkZnNWRjd5dUoxTEpTbmtVTU9CdmxEY2xXVlFMRGRDNFdnLHM9WnF2MDNYb2wrMGtuWnc9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ajNiTVpTZGZzVkY3eXVKMUxKU25rVU1PQnZsRGNsV1ZRTERkQzRXZyxwPXl4T295QTZhNWYvaThaRlpuQ2FhdUUrTDNTdWlFQVR5dThwM3RzNWE5UGc9</response>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1LTEdlMW9GU2lFMjI2RnNVU0NvbmI1Wll2OEw0SVE3dVk1ayt1SThvMnVJPQ==</success>

2019-11-27 20:09:49 | user :: user_cecelr0030@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <iq xmlns="jabber:client" id="3Xi18mZrnXmR9mcTPLTYh2l" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost << <iq type="result" id="3Xi18mZrnXmR9mcTPLTYh2l" xmlns="jabber:client" to="user_cecelr0030@localhost/993927746-tigase-22"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_cecelr0030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="5Vao3zDtoVhCIVTT9uj6tlI" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-22 << <iq type="result" id="5Vao3zDtoVhCIVTT9uj6tlI" xmlns="jabber:client" to="user_cecelr0030@localhost/993927746-tigase-22"/>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="2e3dTSQXnfHQP5eWnNHLIL0" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-22 << <enabled resume="true" id="4bbeff88-69fb-44df-b221-06446eacd43d" xmlns="urn:xmpp:sm:3" max="60" location="d4270859fb27"/>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-22 >> <iq id="a4xu7Fog15hV2piR7gy6FlL" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-22 << <iq from="localhost" type="result" id="2e3dTSQXnfHQP5eWnNHLIL0" xmlns="jabber:client" to="user_cecelr0030@localhost/993927746-tigase-22"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="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:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-22 << <iq type="result" id="a4xu7Fog15hV2piR7gy6FlL" xmlns="jabber:client" to="user_cecelr0030@localhost/993927746-tigase-22"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 20:09:49 | Disconnecting

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

2019-11-27 20:09:49 | [Mutex] notify: [disconnected]

2019-11-27 20:09:49 | [Mutex] received everything.

2019-11-27 20:09:49 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NlY2VscjAwMzAscj1rcXZSRVc0SDdRU0M5ZkY1NXA5bA==</auth>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rcXZSRVc0SDdRU0M5ZkY1NXA5bExyYmR5aU05TXM1U0RPRHp5cTFJLHM9WnF2MDNYb2wrMGtuWnc9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a3F2UkVXNEg3UVNDOWZGNTVwOWxMcmJkeWlNOU1zNVNET0R6eXExSSxwPWwvS1NHVld6WCtJMVNhYjBNTWVMVEN1a25YcFpzRTBCeUpZY0J4dG9IK289</response>

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

2019-11-27 20:09:49 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:49 | [Mutex] received everything.

2019-11-27 20:09:49 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:49 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NlY2VscjAwMzAscj1wZkhhRExDNGpmMmRjRVVKWW5KTw==</auth>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wZkhhRExDNGpmMmRjRVVKWW5KT3RpTUtjcGowODQwM0d6QURpZ0JoLHM9WnF2MDNYb2wrMGtuWnc9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cGZIYURMQzRqZjJkY0VVSlluSk90aU1LY3BqMDg0MDNHekFEaWdCaCxwPUpVSEtSNXhrT05MeURhNHNvREtZVmt3R3V4ZEJQOEFyajljSGlEaDVxSzQ9</response>

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

2019-11-27 20:09:49 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:49 | [Mutex] received everything.

2019-11-27 20:09:49 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 20:09:49 | [Mutex] waiting for: [event]

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

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

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

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NlY2VscjAwMzAscj1uNHY5Yml6UlBwelJtVlJ2cGFZRg==</auth>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uNHY5Yml6UlBwelJtVlJ2cGFZRmhnZ2NwSzdlTURaSDRSSXlEWkZtLHM9WnF2MDNYb2wrMGtuWnc9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bjR2OWJpelJQcHpSbVZSdnBhWUZoZ2djcEs3ZU1EWkg0Ukl5RFpGbSxwPUdKSjYrTzJVQ3NaUDAxMVNCQW9iVnR0emtKdHduY1JMWS82Z09IZzhBTDA9</response>

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

2019-11-27 20:09:49 | [Mutex] notify: [event, authFailed]

2019-11-27 20:09:49 | [Mutex] received everything.

2019-11-27 20:09:49 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NlY2VscjAwMzAscj1ZaEdPb1FiV1RJUGdtSzRPbUx2aQ==</auth>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZaEdPb1FiV1RJUGdtSzRPbUx2aWlXT0EzNWFXWE5BT3U3eGhmcFk5LHM9WnF2MDNYb2wrMGtuWnc9PSxpPTQwOTY=</challenge>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WWhHT29RYldUSVBnbUs0T21MdmlpV09BMzVhV1hOQU91N3hoZnBZOSxwPS9jZ1piZ0VpbVhBcDhsR1pUbjRxUjl4QnJFM1IrdGYzRFVuT0dlbXFoSW89</response>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1nQlpQbkgxOW5DQU9IK3J1M29pUVgrbURYWUl1b2szU2dpZGFQcUJtbmlvPQ==</success>

2019-11-27 20:09:49 | user :: user_cecelr0030@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost >> <iq xmlns="jabber:client" id="JjeuspRP1eN4pdsWSdrX3Bk" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-23 << <iq type="result" id="YmlFpXpWgFNGsbP9vs3x8KZ" xmlns="jabber:client" to="user_cecelr0030@localhost/993927746-tigase-23"/>

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

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

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-23 << <enabled resume="true" id="fef343fb-34da-4b33-a202-2bd9f0f9a2d0" xmlns="urn:xmpp:sm:3" max="60" location="d4270859fb27"/>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-23 >> <iq id="lgZq7DiCeVRNJX2s3zeyndV" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-23 << <iq from="localhost" type="result" id="bmjJTQaPHvnWdU5zamITNFt" xmlns="jabber:client" to="user_cecelr0030@localhost/993927746-tigase-23"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="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:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

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

2019-11-27 20:09:49 | user :: user_cecelr0030@localhost/993927746-tigase-23 << <iq type="result" id="lgZq7DiCeVRNJX2s3zeyndV" xmlns="jabber:client" to="user_cecelr0030@localhost/993927746-tigase-23"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 20:09:49 | Disconnecting

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

2019-11-27 20:09:50 | [Mutex] notify: [disconnected]

2019-11-27 20:09:50 | [Mutex] received everything.

2019-11-27 20:09:52 | [Mutex] waiting for: [user]

2019-11-27 20:09:52 | [Mutex] received everything.

2019-11-27 20:09:52 | [Mutex] isItemNotified: user:ok:true :: true