Brute Force Prevention

Test duration: 15.501s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.491s
2019-11-24 19:24:27 |

2019-11-24 19:24:27 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-24 19:24:27 | ------------------------------------

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2e3934e1

2019-11-24 19:24:27 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1d18b57d}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20fedf56}, 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@24c15f91}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61c3d56d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@63a7b88}, 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=Sun Nov 24 19:24:27 PST 2019}}}}

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@50e81076

2019-11-24 19:24:27 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20fedf56}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@24c15f91}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61c3d56d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@63a7b88}, 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=Sun Nov 24 19:24:27 PST 2019}}}}

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@7efbe02d

2019-11-24 19:24:27 | [Mutex] waiting for: [registration]

2019-11-24 19:24:27 | 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-24 19:24:27 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ec2a22}

2019-11-24 19:24:27 | 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-24 19:24:27 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@54dfe7ac

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@442426e1

2019-11-24 19:24:27 | 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-24 19:24:27 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@65ff4cc0}

2019-11-24 19:24:27 | 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-24 19:24:27 | user :: null >> <iq to="localhost" id="9B4j5s6n6Ds1jVdviY4eweJ" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 19:24:27 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@aa8d386c}

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

2019-11-24 19:24:27 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5a2d767}

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@2eebb2f8

2019-11-24 19:24:27 | user :: null >> <iq to="localhost" id="YB2jSTQGNXjQKUgJFNSW3sl" type="set"><query xmlns="jabber:iq:register"><username>user_awa6ln0027</username><password>user_awa6ln0027</password><email>f484934d-2da8-4f8c-8930-970fd74b0695@localhost</email></query></iq>

2019-11-24 19:24:27 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b1e37753}

2019-11-24 19:24:27 | user :: null << <iq id="YB2jSTQGNXjQKUgJFNSW3sl" xmlns="jabber:client" from="localhost" type="result"/>

2019-11-24 19:24:27 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4b1d9aea}

2019-11-24 19:24:27 | [Mutex] received everything.

2019-11-24 19:24:27 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 19:24:27 | 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;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ec2a22, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@65ff4cc0]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20fedf56}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@24c15f91}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61c3d56d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@63a7b88}, 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=Sun Nov 24 19:24:27 PST 2019}}}}

2019-11-24 19:24:27 | 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;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ec2a22, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@65ff4cc0]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20fedf56}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@24c15f91}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61c3d56d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@63a7b88}, 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=Sun Nov 24 19:24:27 PST 2019}}}}

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@549b4605

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@4791ba1e

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@341ebc66

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1373aac5

2019-11-24 19:24:27 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1d566dc0

2019-11-24 19:24:27 | user :: user_awa6ln0027@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-24 19:24:27 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:27 | user :: user_awa6ln0027@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-24 19:24:27 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1FbXJ6dHFQOVIyWGFEbDVkTExjOA==</auth>

2019-11-24 19:24:27 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FbXJ6dHFQOVIyWGFEbDVkTExjODZVVWp0VTViVm04Q0d1WlNBbmtqLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:27 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RW1yenRxUDlSMlhhRGw1ZExMYzg2VVVqdFU1YlZtOENHdVpTQW5raixwPXI1dURZYVlUZ2ZjeUlSaWVoUEo2Z3JrWkNYd2VnTnBHb3BSK202Rktmbnc9</response>

2019-11-24 19:24:27 | user :: user_awa6ln0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj03UVNCNzNrVUFUT1VJWDdkN0JTQjZyZFB1TlRSMmZqL1l4WjQxQ0huN0RRPQ==</success>

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

2019-11-24 19:24:27 | user :: user_awa6ln0027@localhost >> <iq xmlns="jabber:client" id="HTS0czup07vjZ3oas04kV6l" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-24 19:24:27 | user :: user_awa6ln0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="sD4n09mIR5zmMYoZbPW4jYn" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 19:24:27 | user :: user_awa6ln0027@localhost/993927746-tigase-19 << <iq id="sD4n09mIR5zmMYoZbPW4jYn" xmlns="jabber:client" to="user_awa6ln0027@localhost/993927746-tigase-19" type="result"/>

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

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

2019-11-24 19:24:27 | user :: user_awa6ln0027@localhost/993927746-tigase-19 << <enabled location="d4270859fb27" id="c913c218-7ba9-4960-afad-d47e4db83793" resume="true" xmlns="urn:xmpp:sm:3" max="60"/>

2019-11-24 19:24:27 | user :: user_awa6ln0027@localhost/993927746-tigase-19 >> <iq id="zQDDu2uq3j5s6n6Ds1jVdvi" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:24:27 | user :: user_awa6ln0027@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-24 19:24:27 | user :: user_awa6ln0027@localhost/993927746-tigase-19 << <iq id="CwHM0dDJKGxqhKBtfRNS8oS" xmlns="jabber:client" from="localhost" to="user_awa6ln0027@localhost/993927746-tigase-19" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10589/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10589/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push: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-24 19:24:27 | user :: user_awa6ln0027@localhost/993927746-tigase-19 << <iq id="zQDDu2uq3j5s6n6Ds1jVdvi" xmlns="jabber:client" to="user_awa6ln0027@localhost/993927746-tigase-19" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:24:27 | Disconnecting

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

2019-11-24 19:24:27 | [Mutex] notify: [disconnected]

2019-11-24 19:24:27 | [Mutex] received everything.

2019-11-24 19:24:27 | [Mutex] waiting for: [event]

2019-11-24 19:24:27 | user :: user_awa6ln0027@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-24 19:24:27 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1QMUE5eU9qWnJudkxLOUtsNzFQUg==</auth>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QMUE5eU9qWnJudkxLOUtsNzFQUkdYaDlJcHF5ZTVEZXhNYkZ3OWxkLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UDFBOXlPalpybnZMSzlLbDcxUFJHWGg5SXBxeWU1RGV4TWJGdzlsZCxwPTVLY1R2YnZIbGh1c200UXZ3ckpLRXF4MXRlbmJRQ29XUkgvMlEyT3lybU09</response>

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

2019-11-24 19:24:28 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:28 | [Mutex] received everything.

2019-11-24 19:24:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:28 | [Mutex] waiting for: [event]

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1WaHVRajFQZUJUclJaZXR1TDA0Sg==</auth>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WaHVRajFQZUJUclJaZXR1TDA0SmNiUlJOdFpDc2k4Qm9oUW5oVWNrLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Vmh1UWoxUGVCVHJSWmV0dUwwNEpjYlJSTnRaQ3NpOEJvaFFuaFVjayxwPXNudkFBWCtpYjhHdHVxOTR4cTZ2eEdKQ2thYkJwWEh3dU9rM3ROOVpwcW89</response>

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

2019-11-24 19:24:28 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:28 | [Mutex] received everything.

2019-11-24 19:24:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:28 | [Mutex] waiting for: [event]

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1tQjJFcjRzbU1HTUVWejlDRmlucg==</auth>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tQjJFcjRzbU1HTUVWejlDRmlucnJFUG93YTFNajM1R1hGOFpSMjQzLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bUIyRXI0c21NR01FVno5Q0ZpbnJyRVBvd2ExTWozNUdYRjhaUjI0MyxwPVgzRTB1VWhjTFNrVHF5aTRJQUVWQXdnczhzYVEwUC9URUNyWnZsalk1eDA9</response>

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

2019-11-24 19:24:28 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:28 | [Mutex] received everything.

2019-11-24 19:24:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:28 | [Mutex] waiting for: [event]

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1qZTR1bDdWRjhYTjlyQnhxVWJQRw==</auth>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qZTR1bDdWRjhYTjlyQnhxVWJQRzlNYXB0Umw1eHljN2tVVUk1THB5LHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9amU0dWw3VkY4WE45ckJ4cVViUEc5TWFwdFJsNXh5YzdrVVVJNUxweSxwPWNxUlVEcHo2cTNjc0pMYWRXWGpIWXVvczAxYm8zc0NMUDlEYWpQWWdJWjQ9</response>

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

2019-11-24 19:24:28 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:28 | [Mutex] received everything.

2019-11-24 19:24:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:28 | [Mutex] waiting for: [event]

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1GdE5ibjdDZnFWSEIyZXV6bEhtNg==</auth>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GdE5ibjdDZnFWSEIyZXV6bEhtNmpSUDFsdDFLUVFXVzZhWW9CeXRyLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RnROYm43Q2ZxVkhCMmV1emxIbTZqUlAxbHQxS1FRV1c2YVlvQnl0cixwPXdvOHE5VEUwVlJZeENVcU0vL0R6VFVYci9yQ21aSnYzeEZqWU1MZFVNQTQ9</response>

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

2019-11-24 19:24:28 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:28 | [Mutex] received everything.

2019-11-24 19:24:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:28 | [Mutex] waiting for: [event]

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1vYm1ZbTlzTDdLWWx0ZzliWDRpNw==</auth>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vYm1ZbTlzTDdLWWx0ZzliWDRpN09JS3JVNmtQUjE4MzU1dFlwb1o2LHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b2JtWW05c0w3S1lsdGc5Ylg0aTdPSUtyVTZrUFIxODM1NXRZcG9aNixwPXdIRXhaTkVVQWpNYVlRTFcxK1VzbHhGb0p3cEpUTnBWUC9SUjVNdUlRTHc9</response>

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

2019-11-24 19:24:28 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:28 | [Mutex] notify: [event, disconnected]

2019-11-24 19:24:28 | [Mutex] received everything.

2019-11-24 19:24:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:28 | [Mutex] waiting for: [event]

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1WSXFxN0IySkxkTkVKMXB0dm9tdA==</auth>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WSXFxN0IySkxkTkVKMXB0dm9tdEx3NW90ck1YUWZCeEZlV01pN0d0LHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VklxcTdCMkpMZE5FSjFwdHZvbXRMdzVvdHJNWFFmQnhGZVdNaTdHdCxwPXhoM1Y5WWEwUkxMRGFranFocEFzM1dPZ0FlQ3NXWmdyZVVYcEdabW1tQnM9</response>

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

2019-11-24 19:24:28 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:28 | [Mutex] notify: [event, disconnected]

2019-11-24 19:24:28 | [Mutex] received everything.

2019-11-24 19:24:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:28 | [Mutex] waiting for: [event]

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1GcXpLZURxeFc1YVdCeGtjWkdzcg==</auth>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GcXpLZURxeFc1YVdCeGtjWkdzck5qMG1CdlpwV0ZnOW8xazRwZGpxLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:28 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RnF6S2VEcXhXNWFXQnhrY1pHc3JOajBtQnZacFdGZzlvMWs0cGRqcSxwPTRNVElnZnh5THQyNnJpcVJxc2V3SnZpL0dBS0ljbkZoYnRMeGIyTzJGUVU9</response>

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

2019-11-24 19:24:28 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:28 | [Mutex] received everything.

2019-11-24 19:24:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:28 | [Mutex] waiting for: [event]

2019-11-24 19:24:28 | user :: user_awa6ln0027@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-24 19:24:28 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1DOUROdzVtZTJ3elk0ZUpmMGdmdw==</auth>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DOUROdzVtZTJ3elk0ZUpmMGdmd0hlUUNOem00Y2duM1pqVUFoOUhOLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QzlETnc1bWUyd3pZNGVKZjBnZndIZVFDTnptNGNnbjNaalVBaDlITixwPW43Y3p3dk1xbkt5RzJuQ2FSL0F4WmF2cXBZc2tMMElzZWdwODdycmZpdnc9</response>

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

2019-11-24 19:24:29 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:29 | [Mutex] received everything.

2019-11-24 19:24:29 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:29 | [Mutex] waiting for: [event]

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1zcm9YRHdmVEFnQ3djTXFDZkNyTA==</auth>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zcm9YRHdmVEFnQ3djTXFDZkNyTHhYc1NhTjdHeXZLQThEY0FHNEg3LHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c3JvWER3ZlRBZ0N3Y01xQ2ZDckx4WHNTYU43R3l2S0E4RGNBRzRINyxwPVdwT1I0cGNoblVxL2RtVVBPM1puTUdQd3E1MFVveGh3MTI2Z1QvUHdmbk09</response>

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

2019-11-24 19:24:29 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:29 | [Mutex] received everything.

2019-11-24 19:24:29 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:29 | [Mutex] waiting for: [event]

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1TbE1CaTNJY0lFTHFNOTFTY2V0MA==</auth>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TbE1CaTNJY0lFTHFNOTFTY2V0MExmOUpDN0F0Tkh2STBUNTRJdDlULHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U2xNQmkzSWNJRUxxTTkxU2NldDBMZjlKQzdBdE5IdkkwVDU0SXQ5VCxwPW12T1dJcmhzODcrTXlUdnl5bEtxTWNmUEtSNGZoRW81YXVnQzB1cFN3a009</response>

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

2019-11-24 19:24:29 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:29 | [Mutex] received everything.

2019-11-24 19:24:29 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:29 | [Mutex] waiting for: [event]

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1QbDBuZWR5WHRvMDRiNnd5ZDFHRQ==</auth>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QbDBuZWR5WHRvMDRiNnd5ZDFHRUQxWFluTG85MmwxN2k5cWZ1UkZNLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UGwwbmVkeVh0bzA0YjZ3eWQxR0VEMVhZbkxvOTJsMTdpOXFmdVJGTSxwPWhIL3FvTzFadGxkRUlRMjIzN2hCVDQ1UHBzR1l4bVFOcmFacEJCMWhZTDQ9</response>

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

2019-11-24 19:24:29 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:29 | [Mutex] received everything.

2019-11-24 19:24:29 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:29 | [Mutex] waiting for: [event]

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj11N1pUTDk5WVFnYlNmNDFKOThLdw==</auth>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11N1pUTDk5WVFnYlNmNDFKOThLd1VoMlFLU1RDQ0I2bEFiaXVWNnpQLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dTdaVEw5OVlRZ2JTZjQxSjk4S3dVaDJRS1NUQ0NCNmxBYml1VjZ6UCxwPUZtZ1VqVG84cFFwU2wvSXB1VldhNk1pWkoyNDhTazJ1dXlTT0kzUTZBbWc9</response>

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

2019-11-24 19:24:29 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:29 | [Mutex] received everything.

2019-11-24 19:24:29 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:29 | [Mutex] waiting for: [event]

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1OM1ZyMlpST3RaYmNjUkVhYUUydQ==</auth>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OM1ZyMlpST3RaYmNjUkVhYUUydU84QjNaeWdncGdIR2t5bHpzRjNtLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TjNWcjJaUk90WmJjY1JFYWFFMnVPOEIzWnlnZ3BnSEdreWx6c0YzbSxwPUh4YVJyWnhWRWhvdG1EV3kzQ2FpRlprVm9WMFRmNDEyODgrWG9sMTJHL0k9</response>

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

2019-11-24 19:24:29 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:29 | [Mutex] received everything.

2019-11-24 19:24:29 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:29 | [Mutex] notify: [event, disconnected]

2019-11-24 19:24:29 | [Mutex] waiting for: [event]

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1WOWkxM0dEdVBLSE0xc3ZHcW12ZA==</auth>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WOWkxM0dEdVBLSE0xc3ZHcW12ZGlZbWFHc2haZXo4Q2FPa01pY1o1LHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:29 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VjlpMTNHRHVQS0hNMXN2R3FtdmRpWW1hR3NoWmV6OENhT2tNaWNaNSxwPWRiRStDRDRUN3lxSE1hWklNVVpTSHM4TXRoTnp0dC9Eb3lpcWhuZFlEMTg9</response>

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

2019-11-24 19:24:29 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:29 | [Mutex] received everything.

2019-11-24 19:24:29 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:29 | [Mutex] waiting for: [event]

2019-11-24 19:24:29 | user :: user_awa6ln0027@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-24 19:24:29 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1lNlMwVHFYaFpOVGJJcjJCaWlGVw==</auth>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lNlMwVHFYaFpOVGJJcjJCaWlGV3dITVc0MThHcllsUmYyWlAzZVZ0LHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZTZTMFRxWGhaTlRiSXIyQmlpRld3SE1XNDE4R3JZbFJmMlpQM2VWdCxwPVdWR0hwZUVqeXlLTStsd3R3TU1tb2FJVkk0d29vUUduMW5sVFNnelFPNGs9</response>

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

2019-11-24 19:24:30 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:30 | [Mutex] received everything.

2019-11-24 19:24:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:30 | [Mutex] notify: [event, disconnected]

2019-11-24 19:24:30 | [Mutex] waiting for: [event]

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1qYlZTUHhkRnRpMjlZQ1pUbGZlQw==</auth>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qYlZTUHhkRnRpMjlZQ1pUbGZlQ1MxeUpFOTNKZXAyY04yRFJoSUtqLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9amJWU1B4ZEZ0aTI5WUNaVGxmZUNTMXlKRTkzSmVwMmNOMkRSaElLaixwPXRsZGtYK0RWWDY4YXJLWUJseHRlT3kwaTduL1AyOURkWXc5YUx6ZTJ5Um89</response>

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

2019-11-24 19:24:30 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:30 | [Mutex] received everything.

2019-11-24 19:24:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:30 | [Mutex] waiting for: [event]

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1lSEw3NFlUU25hMEQzSWx0enllVg==</auth>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lSEw3NFlUU25hMEQzSWx0enllVk0wQXh5UTdUbnU0STAxQ1oyZVhzLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZUhMNzRZVFNuYTBEM0lsdHp5ZVZNMEF4eVE3VG51NEkwMUNaMmVYcyxwPUl6bm5FUG5Zc0g2N2NPUldyLy9FcjJRdHdBQ2pPSTF0WEJWUGZPelhROFU9</response>

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

2019-11-24 19:24:30 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:30 | [Mutex] received everything.

2019-11-24 19:24:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:30 | [Mutex] waiting for: [event]

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1PZGE5UEE3UnZvbVkwdllReGZ0NQ==</auth>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PZGE5UEE3UnZvbVkwdllReGZ0NWlveDlJdXlsM0M4VVBSa2o1TjBWLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T2RhOVBBN1J2b21ZMHZZUXhmdDVpb3g5SXV5bDNDOFVQUmtqNU4wVixwPVFKZEZhMXlzYWdqeXhPTnRTZklwM3ZSbnpiUC80TUhocXVtU1RIUXk1OWc9</response>

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

2019-11-24 19:24:30 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:30 | [Mutex] received everything.

2019-11-24 19:24:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:30 | [Mutex] waiting for: [event]

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1HTGR5SHRWUUxNQ0RVQ3l3RkRPSQ==</auth>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HTGR5SHRWUUxNQ0RVQ3l3RkRPSUFhYnpkOHRwQ1NDZFFOYnVubENaLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R0xkeUh0VlFMTUNEVUN5d0ZET0lBYWJ6ZDh0cENTQ2RRTmJ1bmxDWixwPVloTFcxcEkzUGdpZWtFYnBIcTcwOVFGL1kwYkZxa0JvbU1wdWdDV1pWN3M9</response>

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

2019-11-24 19:24:30 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:30 | [Mutex] received everything.

2019-11-24 19:24:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:30 | [Mutex] waiting for: [event]

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1wMmdwcnJLRDNjMmJENEdCMERMdw==</auth>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wMmdwcnJLRDNjMmJENEdCMERMd25MMW9PZVMyOHhoeHp5Mld4WE1yLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cDJncHJyS0QzYzJiRDRHQjBETHduTDFvT2VTMjh4aHh6eTJXeFhNcixwPUVMNTlvVmMrd2l3bDhWL1hreHg3dDNVQ3BXSlRRZjlOQlFVSFErRTFhbGs9</response>

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

2019-11-24 19:24:30 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:30 | [Mutex] received everything.

2019-11-24 19:24:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:30 | user :: user_awa6ln0027@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-24 19:24:30 | user :: user_awa6ln0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3YTZsbjAwMjcscj1BOWdPMFdGNXJUZWQwUmo5blpsMA==</auth>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BOWdPMFdGNXJUZWQwUmo5blpsMER6Nk9NeHg1ZnpYak5TMTc0d0lBLHM9cTZVQXRLSElxZnQ2cHc9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:30 | user :: user_awa6ln0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QTlnTzBXRjVyVGVkMFJqOW5abDBEejZPTXh4NWZ6WGpOUzE3NHdJQSxwPThpQzVFcTlaazkvakU2a2p5dlNSclVsK004TTNLNnhIZXNjTEpwb3JhdjQ9</response>

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

2019-11-24 19:24:32 | [Mutex] waiting for: [user]

2019-11-24 19:24:32 | [Mutex] received everything.

2019-11-24 19:24:32 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.427s
2019-11-24 19:24:32 |

2019-11-24 19:24:32 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-24 19:24:32 | ------------------------------------

2019-11-24 19:24:32 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@72f70e77

2019-11-24 19:24:32 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1d18b57d}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7c30fe59}, 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@780f6507}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3d0df462}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7743d102}, 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=Sun Nov 24 19:24:32 PST 2019}}}}

2019-11-24 19:24:32 | [Mutex] waiting for: [registration]

2019-11-24 19:24:32 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@cfa2b85

2019-11-24 19:24:32 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7c30fe59}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@780f6507}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3d0df462}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7743d102}, 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=Sun Nov 24 19:24:32 PST 2019}}}}

2019-11-24 19:24:32 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@f5e5040

2019-11-24 19:24:32 | 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-24 19:24:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5d220b2d}

2019-11-24 19:24:33 | 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-24 19:24:33 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 19:24:33 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@34800a4a

2019-11-24 19:24:33 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@69fba95c

2019-11-24 19:24:33 | 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-24 19:24:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@145a3873}

2019-11-24 19:24:33 | 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-24 19:24:33 | user :: null >> <iq to="localhost" id="wALupbLKywubzBuavm9u5rb" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 19:24:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@22ddda99}

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

2019-11-24 19:24:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@596c32b6}

2019-11-24 19:24:33 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6d8aa18b

2019-11-24 19:24:33 | user :: null >> <iq to="localhost" id="wBMwtj1gAACr5DyiLSbydHH" type="set"><query xmlns="jabber:iq:register"><username>user_yjhud70028</username><password>user_yjhud70028</password><email>edbd6d0c-1ffa-49b0-82da-c0e6c6d9f248@localhost</email></query></iq>

2019-11-24 19:24:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5ec3ae39}

2019-11-24 19:24:33 | user :: null << <iq id="wBMwtj1gAACr5DyiLSbydHH" xmlns="jabber:client" from="localhost" type="result"/>

2019-11-24 19:24:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@590f442f}

2019-11-24 19:24:33 | [Mutex] received everything.

2019-11-24 19:24:33 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 19:24:33 | 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;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5d220b2d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@145a3873]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7c30fe59}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@780f6507}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3d0df462}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7743d102}, 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=Sun Nov 24 19:24:33 PST 2019}}}}

2019-11-24 19:24:33 | 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;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5d220b2d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@145a3873]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7c30fe59}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@780f6507}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3d0df462}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7743d102}, 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=Sun Nov 24 19:24:33 PST 2019}}}}

2019-11-24 19:24:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1cd366dd

2019-11-24 19:24:33 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@24920e73

2019-11-24 19:24:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1cac7593

2019-11-24 19:24:33 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3f217415

2019-11-24 19:24:33 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@38c318a2

2019-11-24 19:24:33 | user :: user_yjhud70028@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-24 19:24:33 | user :: user_yjhud70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:33 | user :: user_yjhud70028@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-24 19:24:33 | user :: user_yjhud70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lqaHVkNzAwMjgscj1KNUh1bk5jQWVEczdqTFNjVUFQRg==</auth>

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KNUh1bk5jQWVEczdqTFNjVUFQRmdJSDFCUENMb1ljdGJnNFMzb3RNLHM9YjZlTnBJN2o2YXpGekE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SjVIdW5OY0FlRHM3akxTY1VBUEZnSUgxQlBDTG9ZY3RiZzRTM290TSxwPWVrdW1OVXpTY0FDc2d0OEdLQStpN1NWaTBkZHZVVUtFc3ZkbFQ1S2ZNUlU9</response>

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj00Y0s0UGNneURiTy9nT1lYb0VCTVBZbElHUVR3MG9lOFNQVnNZcDA3bzNFPQ==</success>

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

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost >> <iq xmlns="jabber:client" id="NKbr9BzdIOKAeEzoVUO3tlU" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="YLcDwbqQ7BBqUeU1fXcAl2v" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost/993927746-tigase-20 << <iq id="YLcDwbqQ7BBqUeU1fXcAl2v" xmlns="jabber:client" to="user_yjhud70028@localhost/993927746-tigase-20" type="result"/>

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

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

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost/993927746-tigase-20 >> <iq id="rFQQXat00rfT04yyjP7weDC" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost/993927746-tigase-20 << <enabled location="d4270859fb27" id="b5319d78-09c2-4e7e-8ad0-46b7cba5bbca" resume="true" xmlns="urn:xmpp:sm:3" max="60"/>

2019-11-24 19:24:33 | user :: user_yjhud70028@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-24 19:24:33 | user :: user_yjhud70028@localhost/993927746-tigase-20 << <iq id="qGVSW9yfy6DDFyaKW5ndICp" xmlns="jabber:client" from="localhost" to="user_yjhud70028@localhost/993927746-tigase-20" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10589/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10589/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push: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-24 19:24:33 | user :: user_yjhud70028@localhost/993927746-tigase-20 << <iq id="rFQQXat00rfT04yyjP7weDC" xmlns="jabber:client" to="user_yjhud70028@localhost/993927746-tigase-20" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:24:33 | Disconnecting

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

2019-11-24 19:24:33 | [Mutex] notify: [disconnected]

2019-11-24 19:24:33 | [Mutex] received everything.

2019-11-24 19:24:33 | [Mutex] waiting for: [event]

2019-11-24 19:24:33 | user :: user_yjhud70028@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-24 19:24:33 | user :: user_yjhud70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:33 | user :: user_yjhud70028@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-24 19:24:33 | user :: user_yjhud70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lqaHVkNzAwMjgscj1McFd2N3R0TDBmN2d4OEhUOGF0RQ==</auth>

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1McFd2N3R0TDBmN2d4OEhUOGF0RVlVem5rdlhReVJYMmVqWWdPSXBJLHM9YjZlTnBJN2o2YXpGekE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9THBXdjd0dEwwZjdneDhIVDhhdEVZVXpua3ZYUXlSWDJlallnT0lwSSxwPWpTbHhFbEZCOTNMQU9XOUF6dzhvbHUxZlJiMkJVS3ptS0lDY283MlJzSkU9</response>

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

2019-11-24 19:24:33 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:33 | [Mutex] received everything.

2019-11-24 19:24:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:33 | [Mutex] waiting for: [event]

2019-11-24 19:24:33 | user :: user_yjhud70028@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-24 19:24:33 | user :: user_yjhud70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:33 | user :: user_yjhud70028@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-24 19:24:33 | user :: user_yjhud70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lqaHVkNzAwMjgscj1UOFBFS1Fmeng1aDQ3NVdiaWNsVw==</auth>

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UOFBFS1Fmeng1aDQ3NVdiaWNsVzdxYmlaOUgxWThqTW9JSmdhTTBKLHM9YjZlTnBJN2o2YXpGekE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VDhQRUtRZnp4NWg0NzVXYmljbFc3cWJpWjlIMVk4ak1vSUpnYU0wSixwPVE2MGo0enNUOVZMaVJxcWgwQWJ5dk0wWnFPMGN0VEMybWZoL294bkxXWHc9</response>

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

2019-11-24 19:24:33 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:33 | [Mutex] received everything.

2019-11-24 19:24:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:33 | [Mutex] waiting for: [event]

2019-11-24 19:24:33 | user :: user_yjhud70028@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-24 19:24:33 | user :: user_yjhud70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:33 | user :: user_yjhud70028@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-24 19:24:33 | user :: user_yjhud70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lqaHVkNzAwMjgscj0weVhySEF6VDZwdm54c3NhRExYWQ==</auth>

2019-11-24 19:24:33 | user :: user_yjhud70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0weVhySEF6VDZwdm54c3NhRExYWTBGT3Z4aHpid0pPOUh3Q1BSbDBxLHM9YjZlTnBJN2o2YXpGekE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:34 | user :: user_yjhud70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MHlYckhBelQ2cHZueHNzYURMWFkwRk92eGh6YndKTzlId0NQUmwwcSxwPTR0TGVQZXpBTlBXQ2VtNzBUU2VCeWNUZTNGbkpLdEh1aWgrVTBrK21NMlE9</response>

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

2019-11-24 19:24:34 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:34 | [Mutex] received everything.

2019-11-24 19:24:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:34 | [Mutex] waiting for: [event]

2019-11-24 19:24:34 | user :: user_yjhud70028@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-24 19:24:34 | user :: user_yjhud70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:34 | user :: user_yjhud70028@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-24 19:24:34 | user :: user_yjhud70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lqaHVkNzAwMjgscj1qbmtlVVFvS1hmd1hCRVBFWDYzQg==</auth>

2019-11-24 19:24:34 | user :: user_yjhud70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qbmtlVVFvS1hmd1hCRVBFWDYzQnlMVlpoT21NVmg0ZWFva0pQZjdzLHM9YjZlTnBJN2o2YXpGekE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:34 | user :: user_yjhud70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9am5rZVVRb0tYZndYQkVQRVg2M0J5TFZaaE9tTVZoNGVhb2tKUGY3cyxwPUhOVXdoTGM5eHJKalNZdFdkWlZVbDdmRDFQU1NieTAvaTNWNlJMK25WTmc9</response>

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

2019-11-24 19:24:34 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:34 | [Mutex] received everything.

2019-11-24 19:24:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:34 | user :: user_yjhud70028@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-24 19:24:34 | user :: user_yjhud70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:34 | user :: user_yjhud70028@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-24 19:24:34 | user :: user_yjhud70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lqaHVkNzAwMjgscj16VnJGNnpSTDJQckcxamJrSzJXVQ==</auth>

2019-11-24 19:24:34 | user :: user_yjhud70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16VnJGNnpSTDJQckcxamJrSzJXVVowanpGV0hvOUplVnFkNWpreDhxLHM9YjZlTnBJN2o2YXpGekE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:34 | user :: user_yjhud70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9elZyRjZ6UkwyUHJHMWpia0syV1VaMGp6RldIbzlKZVZxZDVqa3g4cSxwPUJyMitoQzVndlVOTVdTYkJjM1BxZVEvMFVUVjdXREdsOWc1VGlVUXdyb0E9</response>

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

2019-11-24 19:24:36 | [Mutex] waiting for: [user]

2019-11-24 19:24:36 | [Mutex] received everything.

2019-11-24 19:24:36 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.322s
2019-11-24 19:24:36 |

2019-11-24 19:24:36 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-24 19:24:36 | ------------------------------------

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@28dd4db8

2019-11-24 19:24:36 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@261ab6d3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@222526c8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6727bce8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@25559d39}, 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=Sun Nov 24 19:24:36 PST 2019}}}}

2019-11-24 19:24:36 | [Mutex] waiting for: [registration]

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@568a1b6e

2019-11-24 19:24:36 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@261ab6d3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@222526c8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6727bce8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@25559d39}, 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=Sun Nov 24 19:24:36 PST 2019}}}}

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@5d126411

2019-11-24 19:24:36 | 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-24 19:24:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@70843a7}

2019-11-24 19:24:36 | 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-24 19:24:36 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@e3daa2a

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@86a81e8

2019-11-24 19:24:36 | 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-24 19:24:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@46164e18}

2019-11-24 19:24:36 | 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-24 19:24:36 | user :: null >> <iq to="localhost" id="PVwjZ3oas04kV6lKupbLKyw" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 19:24:36 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a3b01edb}

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

2019-11-24 19:24:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3463806}

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6049bebe

2019-11-24 19:24:36 | user :: null >> <iq to="localhost" id="vO9kEJP3kIQ8t9LOONWjOJJ" type="set"><query xmlns="jabber:iq:register"><username>user_ccw9ry0029</username><password>user_ccw9ry0029</password><email>4fb2b0db-9ac7-4493-9fbe-4812a95a2a31@localhost</email></query></iq>

2019-11-24 19:24:36 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5c1c8393}

2019-11-24 19:24:36 | user :: null << <iq id="vO9kEJP3kIQ8t9LOONWjOJJ" xmlns="jabber:client" from="localhost" type="result"/>

2019-11-24 19:24:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3cf0069e}

2019-11-24 19:24:36 | [Mutex] received everything.

2019-11-24 19:24:36 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 19:24:36 | 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;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@70843a7, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@46164e18]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@261ab6d3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@222526c8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6727bce8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@25559d39}, 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=Sun Nov 24 19:24:36 PST 2019}}}}

2019-11-24 19:24:36 | 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;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@70843a7, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@46164e18]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@261ab6d3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@222526c8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6727bce8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@25559d39}, 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=Sun Nov 24 19:24:36 PST 2019}}}}

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@48e2e996

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7ad66e84

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@57c7832e

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6bbfbbbe

2019-11-24 19:24:36 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@344e5106

2019-11-24 19:24:36 | user :: user_ccw9ry0029@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-24 19:24:36 | user :: user_ccw9ry0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@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-24 19:24:36 | user :: user_ccw9ry0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NjdzlyeTAwMjkscj01UDVBWENGT2RSSkN0S1psQmM2Sw==</auth>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01UDVBWENGT2RSSkN0S1psQmM2S3RkUEI5SjZaajBNYVB0R01EOW5hLHM9RzhvYlFmMExuc0Vkb3c9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NVA1QVhDRk9kUkpDdEtabEJjNkt0ZFBCOUo2WmowTWFQdEdNRDluYSxwPWxBWjN3aE11QVprZEpPSFpvdEIwUHhNM1d6Zjdkd3F4aHVseldPejlHWTA9</response>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1lM09qZWZ3OGQydXAzL2pSeGhJT3pNT0ozblYrUEJ0TnZuUkZ2QkdCZU84PQ==</success>

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

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost >> <iq xmlns="jabber:client" id="o4TSQKGDwbqQ7BBqUeU1fXc" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost << <iq id="o4TSQKGDwbqQ7BBqUeU1fXc" xmlns="jabber:client" to="user_ccw9ry0029@localhost/993927746-tigase-21" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_ccw9ry0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="D70q3j5s6n6Ds1jVdviY4ew" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost/993927746-tigase-21 << <iq id="D70q3j5s6n6Ds1jVdviY4ew" xmlns="jabber:client" to="user_ccw9ry0029@localhost/993927746-tigase-21" type="result"/>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="z5S7sYmaxh1kQR4zkLNT9n2" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost/993927746-tigase-21 << <enabled location="d4270859fb27" id="e098940d-9957-4aa5-9f2c-ea1dcdede76f" resume="true" xmlns="urn:xmpp:sm:3" max="60"/>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost/993927746-tigase-21 >> <iq id="KUjWjOJJLTR0oUUSW9yfy6D" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@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-24 19:24:36 | user :: user_ccw9ry0029@localhost/993927746-tigase-21 << <iq id="z5S7sYmaxh1kQR4zkLNT9n2" xmlns="jabber:client" from="localhost" to="user_ccw9ry0029@localhost/993927746-tigase-21" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10589/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10589/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push: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-24 19:24:36 | user :: user_ccw9ry0029@localhost/993927746-tigase-21 << <iq id="KUjWjOJJLTR0oUUSW9yfy6D" xmlns="jabber:client" to="user_ccw9ry0029@localhost/993927746-tigase-21" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:24:36 | Disconnecting

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

2019-11-24 19:24:36 | [Mutex] notify: [disconnected]

2019-11-24 19:24:36 | [Mutex] received everything.

2019-11-24 19:24:36 | [Mutex] waiting for: [event]

2019-11-24 19:24:36 | user :: user_ccw9ry0029@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-24 19:24:36 | user :: user_ccw9ry0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@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-24 19:24:36 | user :: user_ccw9ry0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NjdzlyeTAwMjkscj1wZ0FRS2I2cWlRb0xxa3doMlg0NQ==</auth>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wZ0FRS2I2cWlRb0xxa3doMlg0NUlwRFRPRm9lTHJidHZOTzVjdjA1LHM9RzhvYlFmMExuc0Vkb3c9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:36 | user :: user_ccw9ry0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cGdBUUtiNnFpUW9McWt3aDJYNDVJcERUT0ZvZUxyYnR2Tk81Y3YwNSxwPU1kVHloeTNkUytkUmIxSDlkZ3kvVVFkeHhUZThOc2lzQjAyWGs3VjVJelE9</response>

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

2019-11-24 19:24:36 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:37 | [Mutex] received everything.

2019-11-24 19:24:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:37 | [Mutex] notify: [event, disconnected]

2019-11-24 19:24:37 | [Mutex] waiting for: [event]

2019-11-24 19:24:37 | user :: user_ccw9ry0029@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-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:37 | user :: user_ccw9ry0029@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-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2NjdzlyeTAwMjkscj10UlMwYVN6d2VQajhpVkNWOWxycQ==</auth>

2019-11-24 19:24:37 | user :: user_ccw9ry0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10UlMwYVN6d2VQajhpVkNWOWxycU91S1VSMHJBNWZtUzZPOFVQekdKLHM9NHA0SHE4QzRITi8rd3c9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFJTMGFTendlUGo4aVZDVjlscnFPdUtVUjByQTVmbVM2TzhVUHpHSixwPTh6VnVqY2FlN3FUejJ6emZjVUt1aWRPNHFaND0=</response>

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

2019-11-24 19:24:37 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:37 | [Mutex] received everything.

2019-11-24 19:24:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:37 | [Mutex] waiting for: [event]

2019-11-24 19:24:37 | user :: user_ccw9ry0029@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-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:37 | user :: user_ccw9ry0029@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-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NjdzlyeTAwMjkscj02OVlOalVXVFhpdW5DZWZBU2w4MA==</auth>

2019-11-24 19:24:37 | user :: user_ccw9ry0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02OVlOalVXVFhpdW5DZWZBU2w4ME10SXJPWDFHYjlueHJzNGkydnQyLHM9RzhvYlFmMExuc0Vkb3c9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NjlZTmpVV1RYaXVuQ2VmQVNsODBNdElyT1gxR2I5bnhyczRpMnZ0MixwPTNlaTBJd1BZdmhvdHNPMmEvU2p5Rm9GclZCTDNYSDhwb3draDJ1UEFwU1U9</response>

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

2019-11-24 19:24:37 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:37 | [Mutex] received everything.

2019-11-24 19:24:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:37 | [Mutex] waiting for: [event]

2019-11-24 19:24:37 | user :: user_ccw9ry0029@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-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:37 | user :: user_ccw9ry0029@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-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfY2N3OXJ5MDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-24 19:24:37 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:37 | [Mutex] received everything.

2019-11-24 19:24:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:37 | user :: user_ccw9ry0029@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-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:37 | user :: user_ccw9ry0029@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-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NjdzlyeTAwMjkscj1IbGVwWkh0ek1KN0ZRc3ZpTTd3bg==</auth>

2019-11-24 19:24:37 | user :: user_ccw9ry0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IbGVwWkh0ek1KN0ZRc3ZpTTd3bkluTmxUazFQMDJlekloQ1ZsNERQLHM9RzhvYlFmMExuc0Vkb3c9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:37 | user :: user_ccw9ry0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SGxlcFpIdHpNSjdGUXN2aU03d25Jbk5sVGsxUDAyZXpJaENWbDREUCxwPVB5VmordHRuc3I3S1FDRCtrVWFmc3dWblUrZzlBb0JPbWVjSkF6Qk9FSEU9</response>

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

2019-11-24 19:24:39 | [Mutex] waiting for: [user]

2019-11-24 19:24:39 | [Mutex] received everything.

2019-11-24 19:24:39 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 2.983s
2019-11-24 19:24:39 |

2019-11-24 19:24:39 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-24 19:24:39 | ------------------------------------

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5053b029

2019-11-24 19:24:39 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1d18b57d}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5e944453}, 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@5aabdb59}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1fa94e68}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52b6774c}, 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=Sun Nov 24 19:24:39 PST 2019}}}}

2019-11-24 19:24:39 | [Mutex] waiting for: [registration]

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2e7c1795

2019-11-24 19:24:39 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5e944453}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@5aabdb59}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1fa94e68}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52b6774c}, 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=Sun Nov 24 19:24:39 PST 2019}}}}

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2a897010

2019-11-24 19:24:39 | 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-24 19:24:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f86b127}

2019-11-24 19:24:39 | 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-24 19:24:39 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1e6ba58c

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5065c96b

2019-11-24 19:24:39 | 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-24 19:24:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@318d3a87}

2019-11-24 19:24:39 | 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-24 19:24:39 | user :: null >> <iq to="localhost" id="CQ1qiNN3oY7ABoT3pbraIyc" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 19:24:39 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6a3b552e}

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

2019-11-24 19:24:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7bc8aa18}

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@384c3728

2019-11-24 19:24:39 | user :: null >> <iq to="localhost" id="Ub06iEufKDkEJP3kIQ8t9LO" type="set"><query xmlns="jabber:iq:register"><username>user_jhjja80030</username><password>user_jhjja80030</password><email>89a33243-efe0-4b5c-af20-053b041ba05e@localhost</email></query></iq>

2019-11-24 19:24:39 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@89df88f1}

2019-11-24 19:24:39 | user :: null << <iq id="Ub06iEufKDkEJP3kIQ8t9LO" xmlns="jabber:client" from="localhost" type="result"/>

2019-11-24 19:24:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@461c8fdb}

2019-11-24 19:24:39 | [Mutex] received everything.

2019-11-24 19:24:39 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-24 19:24:39 | 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;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f86b127, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@318d3a87]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5e944453}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@5aabdb59}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1fa94e68}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52b6774c}, 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=Sun Nov 24 19:24:39 PST 2019}}}}

2019-11-24 19:24:39 | 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;@1d18b57d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f86b127, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@318d3a87]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5e944453}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@2b624901}, 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@5aabdb59}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1fa94e68}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52b6774c}, 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=Sun Nov 24 19:24:39 PST 2019}}}}

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1e9ddc9d

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@20bb3d3c

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7917bb74

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5bd781da

2019-11-24 19:24:39 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2bded709

2019-11-24 19:24:39 | user :: user_jhjja80030@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-24 19:24:39 | user :: user_jhjja80030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2poamphODAwMzAscj1LRWR2NkNJZ3BVRVRhaTl4YUN0ag==</auth>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LRWR2NkNJZ3BVRVRhaTl4YUN0ajBuYWhQeEZRaDJsaEdyVHpHdTU1LHM9VEZFR20rUjJDSk1ndEE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S0VkdjZDSWdwVUVUYWk5eGFDdGowbmFoUHhGUWgybGhHclR6R3U1NSxwPWlOb0cvbnYxTFBDUEVTaEFqMk5nTmtKMXFEdHFVR1M3VVhveS9Oc2lPMWM9</response>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj01YlBCZ1dqNmsxWFJrVVN0UGVuVUZoMzJ4ZnYxZ1RKRlNuaVlWWjFtaXB3PQ==</success>

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

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost >> <iq xmlns="jabber:client" id="G1up6oXgX6jT5x9AyeyawjS" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost << <iq id="G1up6oXgX6jT5x9AyeyawjS" xmlns="jabber:client" to="user_jhjja80030@localhost/993927746-tigase-22" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_jhjja80030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="Ud2aqU0hOLAaLTbAeScBphQ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-22 << <iq id="Ud2aqU0hOLAaLTbAeScBphQ" xmlns="jabber:client" to="user_jhjja80030@localhost/993927746-tigase-22" type="result"/>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-22 >> <iq to="localhost" id="VYhCiMPUXYWjZnY0qiNN3oY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-22 << <enabled location="d4270859fb27" id="ccdc1d07-386a-4c22-8434-ceb0e04f1431" resume="true" xmlns="urn:xmpp:sm:3" max="60"/>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-22 >> <iq id="c9MIByxgDxn7jUcw8kQXat0" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-22 << <iq id="VYhCiMPUXYWjZnY0qiNN3oY" xmlns="jabber:client" from="localhost" to="user_jhjja80030@localhost/993927746-tigase-22" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10589/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10589/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push: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-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-22 << <iq id="c9MIByxgDxn7jUcw8kQXat0" xmlns="jabber:client" to="user_jhjja80030@localhost/993927746-tigase-22" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:24:40 | Disconnecting

2019-11-24 19:24:40 | [Mutex] notify: [disconnected]

2019-11-24 19:24:40 | [Mutex] received everything.

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

2019-11-24 19:24:40 | [Mutex] waiting for: [event]

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2poamphODAwMzAscj16bUk4RVdDQ0xBcUVJd1MxTnB5TQ==</auth>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16bUk4RVdDQ0xBcUVJd1MxTnB5TVE1UDRGTkhWRno1a1N1YlhLYmpnLHM9VEZFR20rUjJDSk1ndEE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9em1JOEVXQ0NMQXFFSXdTMU5weU1RNVA0Rk5IVkZ6NWtTdWJYS2JqZyxwPWc4ejBqVmZ1TVkwekhqMURDS0FKbTVsWk1pc0d5SWNFQko4VGVwV2ZORVE9</response>

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

2019-11-24 19:24:40 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:40 | [Mutex] received everything.

2019-11-24 19:24:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:40 | [Mutex] waiting for: [event]

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2poamphODAwMzAscj1HUG5WZjNKTkJYZEx5R2JGMThQUw==</auth>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HUG5WZjNKTkJYZEx5R2JGMThQU1FhTEtjNzJVREhTdHUxRGlBQTRlLHM9VEZFR20rUjJDSk1ndEE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R1BuVmYzSk5CWGRMeUdiRjE4UFNRYUxLYzcyVURIU3R1MURpQUE0ZSxwPWo5MjdUOEVqOWg1K0ovYWwvK0hhZ3FsTm9MSzFOQXN6cDkvbGZwT294dXc9</response>

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

2019-11-24 19:24:40 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:40 | [Mutex] received everything.

2019-11-24 19:24:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:40 | [Mutex] waiting for: [event]

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2poamphODAwMzAscj1yUHRlWDUxcGlZV29xMzZPQ0Y5Tw==</auth>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yUHRlWDUxcGlZV29xMzZPQ0Y5T2VoakVIOVlmd3R2eGNXM2tYSlExLHM9VEZFR20rUjJDSk1ndEE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9clB0ZVg1MXBpWVdvcTM2T0NGOU9laGpFSDlZZnd0dnhjVzNrWEpRMSxwPXVWUlhZQWU5K2hZNlVnV3h6ZGZZL0U5TU4vV2JPY090ZjNWc1VhaS9IV1U9</response>

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

2019-11-24 19:24:40 | [Mutex] notify: [event, authFailed]

2019-11-24 19:24:40 | [Mutex] received everything.

2019-11-24 19:24:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2poamphODAwMzAscj1YSHRqSVlyenVEOE4xS2FEeE5EMw==</auth>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YSHRqSVlyenVEOE4xS2FEeE5EM1hndTMwUVhFMm5CVnNoMWxVeXZWLHM9VEZFR20rUjJDSk1ndEE9PSxpPTQwOTY=</challenge>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WEh0aklZcnp1RDhOMUthRHhORDNYZ3UzMFFYRTJuQlZzaDFsVXl2VixwPWRxWGxsRXpjWnNYb0lQbGwzN3Bhd0tNQmZZNENLWC9PWTQvWHd4SlNSL3c9</response>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1hV2hYV3IzNEJzTmhNWDRWQktBUFN2R05udUxLWUR1NVN2NFROblEzOU53PQ==</success>

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

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost >> <iq xmlns="jabber:client" id="DibMLJV8s5wt8n1l3bEGu4c" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost << <iq id="DibMLJV8s5wt8n1l3bEGu4c" xmlns="jabber:client" to="user_jhjja80030@localhost/993927746-tigase-23" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_jhjja80030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="DjcOPRbEu9EJEp5tjHGKCkI" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-23 << <iq id="DjcOPRbEu9EJEp5tjHGKCkI" xmlns="jabber:client" to="user_jhjja80030@localhost/993927746-tigase-23" type="result"/>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-23 >> <iq to="localhost" id="a7ABuavm9u5rbJxm6kKyiRY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-23 >> <iq id="tcNOLAaLTbAeScBphQSVcPQ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:24:40 | user :: user_jhjja80030@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-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-23 << <enabled location="d4270859fb27" id="bdef239c-4b2d-4474-89de-00339202cf3f" resume="true" xmlns="urn:xmpp:sm:3" max="60"/>

2019-11-24 19:24:40 | Disconnecting

2019-11-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-23 << <iq id="a7ABuavm9u5rbJxm6kKyiRY" xmlns="jabber:client" from="localhost" to="user_jhjja80030@localhost/993927746-tigase-23" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10589/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10589/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push: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-24 19:24:40 | user :: user_jhjja80030@localhost/993927746-tigase-23 << <iq id="tcNOLAaLTbAeScBphQSVcPQ" xmlns="jabber:client" to="user_jhjja80030@localhost/993927746-tigase-23" type="result"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-24 19:24:40 | [Mutex] notify: [disconnected]

2019-11-24 19:24:40 | [Mutex] received everything.

2019-11-24 19:24:42 | [Mutex] waiting for: [user]

2019-11-24 19:24:42 | [Mutex] received everything.

2019-11-24 19:24:42 | [Mutex] isItemNotified: user:ok:true :: true