Brute Force Prevention

Test duration: 15.733s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.808s
2020-06-25 23:45:29 |

2020-06-25 23:45:29 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-06-25 23:45:29 | ------------------------------------

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3985edc

2020-06-25 23:45:29 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29537d53}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@d5fa0df}, 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@96035ac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4c62aae4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@dcd630a}, 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=Thu Jun 25 23:45:29 PDT 2020}}}}

2020-06-25 23:45:29 | [Mutex] waiting for: [registration]

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7de46334

2020-06-25 23:45:29 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@d5fa0df}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@96035ac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4c62aae4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@dcd630a}, 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=Thu Jun 25 23:45:29 PDT 2020}}}}

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@75a1f471

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

2020-06-25 23:45:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2c4d55ab}

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

2020-06-25 23:45:29 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-06-25 23:45:29 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4afeb61b

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@145d81b3

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

2020-06-25 23:45:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6ea5fd35}

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

2020-06-25 23:45:29 | user :: null >> <iq to="localhost" id="7Obw9GweCp8iPO4fJtmS8rj" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-06-25 23:45:29 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b8424700}

2020-06-25 23:45:29 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="7Obw9GweCp8iPO4fJtmS8rj"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x xmlns="jabber:x:data" type="form"><title>Account Registration</title><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field var="username" type="text-single" label="Username"><required/><value/></field><field var="password" type="text-private" label="Password"><required/><value/></field><field var="email" type="text-single" label="Email (MUST BE VALID!)"><required/><value/></field></x></query></iq>

2020-06-25 23:45:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@28030d47}

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@17f23832

2020-06-25 23:45:29 | user :: null >> <iq to="localhost" id="u74BvlSP7JX4kLUY8q1mKJC" type="set"><query xmlns="jabber:iq:register"><username>user_z488ww0027</username><password>user_z488ww0027</password><email>bd6bdc39-4507-4ce5-a28a-38056a7a2af1@localhost</email></query></iq>

2020-06-25 23:45:29 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@dc23dda3}

2020-06-25 23:45:29 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="u74BvlSP7JX4kLUY8q1mKJC"/>

2020-06-25 23:45:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6f5a7366}

2020-06-25 23:45:29 | [Mutex] received everything.

2020-06-25 23:45:29 | [Mutex] isItemNotified: registrationSuccess :: true

2020-06-25 23:45:29 | 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;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2c4d55ab, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6ea5fd35]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@d5fa0df}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@96035ac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4c62aae4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@dcd630a}, 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=Thu Jun 25 23:45:29 PDT 2020}}}}

2020-06-25 23:45:29 | 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;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2c4d55ab, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6ea5fd35]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@d5fa0df}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@96035ac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4c62aae4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@dcd630a}, 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=Thu Jun 25 23:45:29 PDT 2020}}}}

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2ed777ed

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1e0e2e45

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@18bba61e

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

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2446272c

2020-06-25 23:45:29 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@31bb5456

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1wa3ZuVlBYZDVmMllUSWpTejZUVA==</auth>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wa3ZuVlBYZDVmMllUSWpTejZUVFczdHpmUVZaNXhYcGtxUUJjZFZ0LHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cGt2blZQWGQ1ZjJZVElqU3o2VFRXM3R6ZlFWWjV4WHBrcVFCY2RWdCxwPU14aE1lZE1CUjRGclByby9MSnVPVHkrOU1jL1U1ZWxCNmFNM0c1M05SUWM9</response>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1adUp4MGljVGF5U2RwR3EvWk1wcTdJY0tVWDdXVlo0NE1ndGFDNU9rYmpRPQ==</success>

2020-06-25 23:45:29 | user :: user_z488ww0027@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" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="fVdfIcSHLKursFAIaH8vkALmkEg="/></features>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <iq xmlns="jabber:client" id="qRgVQKWn3r4dTh3gIxs4kON" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost << <iq xmlns="jabber:client" to="user_z488ww0027@localhost/2095755800-tigase-23" type="result" id="qRgVQKWn3r4dTh3gIxs4kON"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_z488ww0027@localhost/2095755800-tigase-23</jid></bind></iq>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost/2095755800-tigase-23 >> <iq xmlns="jabber:client" id="j96hNBCoavrSO4Dzt8l9N5k" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost/2095755800-tigase-23 << <iq xmlns="jabber:client" to="user_z488ww0027@localhost/2095755800-tigase-23" type="result" id="j96hNBCoavrSO4Dzt8l9N5k"/>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost/2095755800-tigase-23 >> <iq to="localhost" id="4baN5kQNY6oW3qSZ8IxjDGw" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost/2095755800-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost/2095755800-tigase-23 << <enabled xmlns="urn:xmpp:sm:3" max="60" location="9585556aacac" resume="true" id="52d23beb-4bcf-4652-9007-e704adac6b9d"/>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost/2095755800-tigase-23 >> <iq id="hYv8IxjDGwq1tWWk9BxgBFP" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost/2095755800-tigase-23 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost/2095755800-tigase-23 << <iq from="localhost" xmlns="jabber:client" to="user_z488ww0027@localhost/2095755800-tigase-23" type="result" id="4baN5kQNY6oW3qSZ8IxjDGw"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10776/960d5e95"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10776/960d5e95"/><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="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost/2095755800-tigase-23 << <iq xmlns="jabber:client" to="user_z488ww0027@localhost/2095755800-tigase-23" type="result" id="hYv8IxjDGwq1tWWk9BxgBFP"><query xmlns="jabber:iq:roster"/></iq>

2020-06-25 23:45:29 | Disconnecting

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost/2095755800-tigase-23 << <presence xmlns="jabber:client" from="user_z488ww0027@localhost/2095755800-tigase-23" to="user_z488ww0027@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-06-25 23:45:29 | [Mutex] notify: [disconnected]

2020-06-25 23:45:29 | [Mutex] received everything.

2020-06-25 23:45:29 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1raG13RUZoWktEZVpOUUJiUkFybQ==</auth>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1raG13RUZoWktEZVpOUUJiUkFybTdjeFpFQXNycjdZaFJZTEJuODZVLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a2htd0VGaFpLRGVaTlFCYlJBcm03Y3haRUFzcnI3WWhSWUxCbjg2VSxwPWZtYTl1YXkvbjZYaEw0UDg0QlpGek81eEdqNHZSdkt5dURiU0FGYjUrSEU9</response>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:29 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:29 | [Mutex] received everything.

2020-06-25 23:45:29 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:29 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1hYlRTdkNDRmZrc0tmS21iNzdQag==</auth>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hYlRTdkNDRmZrc0tmS21iNzdQakJzNWhOMkFteVpJM2hFTnloQWRDLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YWJUU3ZDQ0Zma3NLZkttYjc3UGpCczVoTjJBbXlaSTNoRU55aEFkQyxwPTVMQVFIaVBMM3JOWXk4T0NTUXdiRnNtSktmc1RpK1NMcXdaNjd5STE5R1E9</response>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:29 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:29 | [Mutex] received everything.

2020-06-25 23:45:29 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:29 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1GalF3cmwzUVdFbjM2VGV6UEhjZg==</auth>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GalF3cmwzUVdFbjM2VGV6UEhjZkxFclJTZmh2cndZckplMUNucEhELHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RmpRd3JsM1FXRW4zNlRlelBIY2ZMRXJSU2ZodnJ3WXJKZTFDbnBIRCxwPXVoS0xqWmlJaDNJNWtGMFZEY1dFOWxhM0RYWVhjMys4VjFXdjdQUzlsb3M9</response>

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:29 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:29 | [Mutex] received everything.

2020-06-25 23:45:29 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:29 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:29 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj16ZnFMaVJuMG8wUFlCTnZQWFpqMQ==</auth>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16ZnFMaVJuMG8wUFlCTnZQWFpqMUVRSklOMzV1djhKc0VBUzJkdmFZLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9emZxTGlSbjBvMFBZQk52UFhaajFFUUpJTjM1dXY4SnNFQVMyZHZhWSxwPWhTbmxNYkFxbGZVeXZTaEVvVTZ6c1dmLzc0TDZZeXVUWmVmcy9FZ2FrMVk9</response>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:30 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:30 | [Mutex] received everything.

2020-06-25 23:45:30 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:30 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj04aUtSNTFpTDF6dUNvWlJrNDdFSQ==</auth>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04aUtSNTFpTDF6dUNvWlJrNDdFSU1rNWxJQ1VXeXVxcG84Rll1RjlQLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OGlLUjUxaUwxenVDb1pSazQ3RUlNazVsSUNVV3l1cXBvOEZZdUY5UCxwPUpGS0JIRnlMeUpYOEZWNENmc2p6TmkzNkZDVm8wYzBxY2pyb0JNSXZ2YTA9</response>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:30 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:30 | [Mutex] received everything.

2020-06-25 23:45:30 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:30 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1wdlcweHdZcWhRTDBGNVRSUGdkUg==</auth>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wdlcweHdZcWhRTDBGNVRSUGdkUmN1blgweHFvV2VHdnNKNTNDcmo5LHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cHZXMHh3WXFoUUwwRjVUUlBnZFJjdW5YMHhxb1dlR3ZzSjUzQ3JqOSxwPXhwcksxbGtLRktqMDFuYk5yZ3p1V2lqcVczbVpaT3B3Z2RrcE8ySTNBSlk9</response>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:30 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:30 | [Mutex] received everything.

2020-06-25 23:45:30 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:30 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj03S2VpQUR3MExJckNGZUc1S3FENw==</auth>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03S2VpQUR3MExJckNGZUc1S3FEN3ZNVVFyV3RqeTVaTXdIYkttVGRPLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N0tlaUFEdzBMSXJDRmVHNUtxRDd2TVVRcld0ank1Wk13SGJLbVRkTyxwPWpad1lGOE1Ydk0wMWRmYVBUWDkrUG51WTdham10WW5IOXp2WGxvSWtpaEE9</response>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:30 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:30 | [Mutex] received everything.

2020-06-25 23:45:30 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:30 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1wOGtZVXRnclE5UlJwTTduWDRiZQ==</auth>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wOGtZVXRnclE5UlJwTTduWDRiZVlsWlFOSmpSYkNTV1h1Umg0d2RKLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cDhrWVV0Z3JROVJScE03blg0YmVZbFpRTkpqUmJDU1dYdVJoNHdkSixwPXRIVkpiYjdHVHExQ1EzK0tETjRiL1hmb0todFZ4bE5BY1hmbmRBem1aM2M9</response>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:30 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:30 | [Mutex] received everything.

2020-06-25 23:45:30 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:30 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1vUlp3R2pvSGRrNUQyR0pkNW5ESA==</auth>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vUlp3R2pvSGRrNUQyR0pkNW5ESFBJbFR4cDJzQTJIMTNmaG10SWw4LHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b1Jad0dqb0hkazVEMkdKZDVuREhQSWxUeHAyc0EySDEzZmhtdElsOCxwPVlzd1pMOXNOek0vWGNiZGdBVjhDdzU2dXVRU0pXRXVTWExXZUFMU2t6ZDg9</response>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:30 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:30 | [Mutex] received everything.

2020-06-25 23:45:30 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:30 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj10V3ZpdU9KaFBmcnhYejlvZGRNZw==</auth>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10V3ZpdU9KaFBmcnhYejlvZGRNZzhKRjZrc3U4dmpMOFJOWWNEZ2dLLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFd2aXVPSmhQZnJ4WHo5b2RkTWc4SkY2a3N1OHZqTDhSTlljRGdnSyxwPTNGbDR5bzFuMExjRVgrWFFqaFE2aEU5K2xqM0xjYU5ZSjExZWRJdS9nSjg9</response>

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:30 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:30 | [Mutex] received everything.

2020-06-25 23:45:30 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:30 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:30 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1kVE55bVBKOUFEUnpCOXBKN0s4Yg==</auth>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kVE55bVBKOUFEUnpCOXBKN0s4YlZtYURXWXhRQ3FyRG5NRG5rS3ZyLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZFROeW1QSjlBRFJ6QjlwSjdLOGJWbWFEV1l4UUNxckRuTURua0t2cixwPVdxWFE4YVJ2em5ML0FYT1AvdXdHM1J5WFJTalJNbFp2SGNnWWU2SUdKUjg9</response>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:31 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:31 | [Mutex] notify: [event, disconnected]

2020-06-25 23:45:31 | [Mutex] received everything.

2020-06-25 23:45:31 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:31 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj0yVFdYN2lRWnNhelZweXFCRm5RMw==</auth>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yVFdYN2lRWnNhelZweXFCRm5RM0htY0RVZGZHdXUwalJPWlFSaExkLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MlRXWDdpUVpzYXpWcHlxQkZuUTNIbWNEVWRmR3V1MGpST1pRUmhMZCxwPXNEanJDTGR5NUhObGowdWdPY3hKb1Q3dnZzWHZaY0VaQWFDamFacXRrdEE9</response>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:31 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:31 | [Mutex] received everything.

2020-06-25 23:45:31 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:31 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1BMXBkOFR2Qk5rSGJLRVpxYTEwSg==</auth>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BMXBkOFR2Qk5rSGJLRVpxYTEwSnJGV3o1RWxqNk15OXFIb2RDRWNDLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QTFwZDhUdkJOa0hiS0VacWExMEpyRld6NUVsajZNeTlxSG9kQ0VjQyxwPXltaVlidzRDMkp0Y0xMVmhnYnN3YjFZZWFIZ1c0dXQxaXNWVDRKSmJjYUE9</response>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:31 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:31 | [Mutex] received everything.

2020-06-25 23:45:31 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:31 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1JZXQ4Z0tPNnhXSEMwUTk4TzNRRQ==</auth>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JZXQ4Z0tPNnhXSEMwUTk4TzNRRTd4WkNDMGpDY255TW80ZnRhOTBULHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SWV0OGdLTzZ4V0hDMFE5OE8zUUU3eFpDQzBqQ2NueU1vNGZ0YTkwVCxwPVZyckZxejFiTzdBRlZ6bVFHZ3duTkpNRmIwa1NLZjFjVG84T3lhYjhFbUk9</response>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:31 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:31 | [Mutex] received everything.

2020-06-25 23:45:31 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:31 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1wTWhMR0NZMWlPMm1YeG5sc29zRQ==</auth>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wTWhMR0NZMWlPMm1YeG5sc29zRVN2UG8wVjY5eDNpM2RhbHRZalRoLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cE1oTEdDWTFpTzJtWHhubHNvc0VTdlBvMFY2OXgzaTNkYWx0WWpUaCxwPWtMdkt5ak94RHF6OVg1emRldkVvU1ExMnZpajhyTnF4R2JOM2VUOWVpckk9</response>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:31 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:31 | [Mutex] received everything.

2020-06-25 23:45:31 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:31 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj13b2tGcFZROWZYSUtLYU9CdFdpdA==</auth>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13b2tGcFZROWZYSUtLYU9CdFdpdHhFRENCV29NbWlQWld2UVY3V0ozLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d29rRnBWUTlmWElLS2FPQnRXaXR4RURDQldvTW1pUFpXdlFWN1dKMyxwPVpidXdNcDhEOE12SEt5aFNDUU85SWZwNUlDYU53Yk5xVDFtODRKUXBFV0U9</response>

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:31 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:31 | [Mutex] received everything.

2020-06-25 23:45:31 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:31 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:31 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1jNjhNWjZwOEdLYzJXN1Y3TUV5dg==</auth>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jNjhNWjZwOEdLYzJXN1Y3TUV5djRWRmJ6aU9KQ2dDMGZTbkpQTldRLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YzY4TVo2cDhHS2MyVzdWN01FeXY0VkZiemlPSkNnQzBmU25KUE5XUSxwPTZjMko0cDVGNXVTb3BoT2t4dmtPYSszRGg5blAzZm1MQ2lPVitnZTBQVDQ9</response>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:32 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:32 | [Mutex] received everything.

2020-06-25 23:45:32 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:32 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1hMkZ6alZrbGxmcDBzZ1hIc0RGag==</auth>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hMkZ6alZrbGxmcDBzZ1hIc0RGalBZQ3dLcHRKeDYxbU5pTXVrRTBHLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YTJGempWa2xsZnAwc2dYSHNERmpQWUN3S3B0Sng2MW1OaU11a0UwRyxwPWJzZTBteVpZTlNwK0tZZDd5bk9BYWlVbi9IOTBDWWRxNTV6TlA3SEFzb0U9</response>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:32 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:32 | [Mutex] received everything.

2020-06-25 23:45:32 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:32 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1BUENWdnBTNzVNeDF6eEZOc3FlVQ==</auth>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BUENWdnBTNzVNeDF6eEZOc3FlVTVOSk1CSzQ3cHJkZ2p2VDBPY0tRLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QVBDVnZwUzc1TXgxenhGTnNxZVU1TkpNQks0N3ByZGdqdlQwT2NLUSxwPXZGTU91ZktxQ09BQ1JoeFd3eW5mMDlIQ0Ixcjg2TE5vVUxCanhSREgrNkU9</response>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:32 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:32 | [Mutex] received everything.

2020-06-25 23:45:32 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:32 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1ld2xERzEySHF5bDhNWFFhenNORQ==</auth>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ld2xERzEySHF5bDhNWFFhenNORTFpN2RoNlFWYVRDUUduTlVDSVlGLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZXdsREcxMkhxeWw4TVhRYXpzTkUxaTdkaDZRVmFUQ1FHbk5VQ0lZRixwPTdVUXpzUzQzVHQxaDhVZVNQT1Z4WXYvMnlXWTB2V3psWG5KM0YxRWVKclE9</response>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:32 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:32 | [Mutex] received everything.

2020-06-25 23:45:32 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:32 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1KQXZDd2JrbExsOWxieEU5Z1ozYw==</auth>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KQXZDd2JrbExsOWxieEU5Z1ozYzBGNHJjemQ5akJXNnJNeVlZY2RaLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SkF2Q3dia2xMbDlsYnhFOWdaM2MwRjRyY3pkOWpCVzZyTXlZWWNkWixwPTBOUkVkNTNuVndlWmZsTktqKzJTZGFnVGFCK3hqaFRURTR4SVpsaUYyZk09</response>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:32 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:32 | [Mutex] received everything.

2020-06-25 23:45:32 | [Mutex] isItemNotified: authFailed :: true

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

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3o0ODh3dzAwMjcscj1UQWZ1Z2Z4VGltRjNpbWFCcTBFVg==</auth>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UQWZ1Z2Z4VGltRjNpbWFCcTBFVm5SVUNkdUtwVzk1aVBWZ0NqUmtXLHM9NlFvOHdaT0JWdHdqbWc9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VEFmdWdmeFRpbUYzaW1hQnEwRVZuUlVDZHVLcFc5NWlQVmdDalJrVyxwPTZYdFdRbWJGTDNLem82Q3k1Z0duSDVvaTZwRVlEckhjWVNhTUd2VFhWZUE9</response>

2020-06-25 23:45:32 | user :: user_z488ww0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: user_z488ww0027@localhost is not authorized to act as user_z488ww0027@localhost</text></failure>

2020-06-25 23:45:34 | [Mutex] waiting for: [user]

2020-06-25 23:45:34 | [Mutex] received everything.

2020-06-25 23:45:34 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.329s
2020-06-25 23:45:34 |

2020-06-25 23:45:34 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-06-25 23:45:34 | ------------------------------------

2020-06-25 23:45:34 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7a82faf4

2020-06-25 23:45:34 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29537d53}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@74451bd4}, 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@707a9184}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@357811ef}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@58c018ee}, 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=Thu Jun 25 23:45:34 PDT 2020}}}}

2020-06-25 23:45:34 | [Mutex] waiting for: [registration]

2020-06-25 23:45:34 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4072399

2020-06-25 23:45:34 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@74451bd4}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@707a9184}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@357811ef}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@58c018ee}, 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=Thu Jun 25 23:45:34 PDT 2020}}}}

2020-06-25 23:45:34 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2055742c

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

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

2020-06-25 23:45:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5557eea0}

2020-06-25 23:45:34 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-06-25 23:45:34 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2020-06-25 23:45:34 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@d889b8c

2020-06-25 23:45:34 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@302e6a4f

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

2020-06-25 23:45:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b519c72}

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

2020-06-25 23:45:34 | user :: null >> <iq to="localhost" id="QTax5Ak2fVQKWn3r4dTh3gI" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-06-25 23:45:34 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ba07b04}

2020-06-25 23:45:34 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="QTax5Ak2fVQKWn3r4dTh3gI"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x xmlns="jabber:x:data" type="form"><title>Account Registration</title><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field var="username" type="text-single" label="Username"><required/><value/></field><field var="password" type="text-private" label="Password"><required/><value/></field><field var="email" type="text-single" label="Email (MUST BE VALID!)"><required/><value/></field></x></query></iq>

2020-06-25 23:45:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@51195756}

2020-06-25 23:45:34 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1804f202

2020-06-25 23:45:34 | user :: null >> <iq to="localhost" id="DXkOJQQSUZiCt6Ep37EsiLX" type="set"><query xmlns="jabber:iq:register"><username>user_gzwavs0028</username><password>user_gzwavs0028</password><email>484648a5-c28b-46d9-a1f8-976228df1a61@localhost</email></query></iq>

2020-06-25 23:45:34 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@38843205}

2020-06-25 23:45:35 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="DXkOJQQSUZiCt6Ep37EsiLX"/>

2020-06-25 23:45:35 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5bbb9f5f}

2020-06-25 23:45:35 | [Mutex] received everything.

2020-06-25 23:45:35 | [Mutex] isItemNotified: registrationSuccess :: true

2020-06-25 23:45:35 | 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;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5557eea0, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b519c72]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@74451bd4}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@707a9184}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@357811ef}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@58c018ee}, 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=Thu Jun 25 23:45:35 PDT 2020}}}}

2020-06-25 23:45:35 | 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;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5557eea0, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b519c72]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@74451bd4}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@707a9184}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@357811ef}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@58c018ee}, 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=Thu Jun 25 23:45:35 PDT 2020}}}}

2020-06-25 23:45:35 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6cbe3a56

2020-06-25 23:45:35 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@77867370

2020-06-25 23:45:35 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@482d1b60

2020-06-25 23:45:35 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4f6b245d

2020-06-25 23:45:35 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@529adb6c

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d6d2F2czAwMjgscj1lR0xQQzNhZlFIZWFYNUVYU2o3cA==</auth>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lR0xQQzNhZlFIZWFYNUVYU2o3cGdTMXdVVXJ0RmRFVmI4aHdoU1JRLHM9VE9sTjVOK1JWS09OZ1E9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZUdMUEMzYWZRSGVhWDVFWFNqN3BnUzF3VVVydEZkRVZiOGh3aFNSUSxwPVZXbGNtd25MQzNzVHF2dDNsODErdkVFbXhVaWIzdmVqQzN1VDZGc0lhVXM9</response>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1FdTNEUGRUN1JnNE9kMHJ2dlY1WHRyQTJ1dVEwVmJYVDZxR0J6ckdGTVgwPQ==</success>

2020-06-25 23:45:35 | user :: user_gzwavs0028@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" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="fVdfIcSHLKursFAIaH8vkALmkEg="/></features>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <iq xmlns="jabber:client" id="3T6DL1cAhW2gGxoORScvfvq" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <iq xmlns="jabber:client" to="user_gzwavs0028@localhost/2095755800-tigase-24" type="result" id="3T6DL1cAhW2gGxoORScvfvq"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_gzwavs0028@localhost/2095755800-tigase-24</jid></bind></iq>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost/2095755800-tigase-24 >> <iq xmlns="jabber:client" id="6knSWZmSW2fOExeUV5bMION" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost/2095755800-tigase-24 << <iq xmlns="jabber:client" to="user_gzwavs0028@localhost/2095755800-tigase-24" type="result" id="6knSWZmSW2fOExeUV5bMION"/>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost/2095755800-tigase-24 >> <iq to="localhost" id="Tg9qeDHoQ8LPZaph3BmUVeC" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost/2095755800-tigase-24 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost/2095755800-tigase-24 << <enabled xmlns="urn:xmpp:sm:3" max="60" location="9585556aacac" resume="true" id="6c0fc213-bfc5-4540-83c5-0385b016dcb7"/>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost/2095755800-tigase-24 >> <iq id="sRUQ8LPZaph3BmUVeCq0bGo" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost/2095755800-tigase-24 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost/2095755800-tigase-24 << <iq from="localhost" xmlns="jabber:client" to="user_gzwavs0028@localhost/2095755800-tigase-24" type="result" id="Tg9qeDHoQ8LPZaph3BmUVeC"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10776/960d5e95"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10776/960d5e95"/><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="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost/2095755800-tigase-24 << <iq xmlns="jabber:client" to="user_gzwavs0028@localhost/2095755800-tigase-24" type="result" id="sRUQ8LPZaph3BmUVeCq0bGo"><query xmlns="jabber:iq:roster"/></iq>

2020-06-25 23:45:35 | Disconnecting

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost/2095755800-tigase-24 << <presence xmlns="jabber:client" from="user_gzwavs0028@localhost/2095755800-tigase-24" to="user_gzwavs0028@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-06-25 23:45:35 | [Mutex] notify: [disconnected]

2020-06-25 23:45:35 | [Mutex] received everything.

2020-06-25 23:45:35 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d6d2F2czAwMjgscj05M3JQRUFSSkNWYTJDblNzOU1QbQ==</auth>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05M3JQRUFSSkNWYTJDblNzOU1QbUh1Nm1VTk5mcjkwaTNqSWhweW5BLHM9VE9sTjVOK1JWS09OZ1E9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OTNyUEVBUkpDVmEyQ25TczlNUG1IdTZtVU5OZnI5MGkzaklocHluQSxwPXF0VEZ2NHhxbStXcnl2dEtYMUNkaDBZaWVHTHY0TXZ0NTFKQjdKMDZLWWM9</response>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:35 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:35 | [Mutex] received everything.

2020-06-25 23:45:35 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:35 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d6d2F2czAwMjgscj1aSG1tV0J6NFBwbWU4OWswTGJWZQ==</auth>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aSG1tV0J6NFBwbWU4OWswTGJWZVhiM0FzdE81R1RoVkpCUktmWmFvLHM9VE9sTjVOK1JWS09OZ1E9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WkhtbVdCejRQcG1lODlrMExiVmVYYjNBc3RPNUdUaFZKQlJLZlphbyxwPUZHV1Y5TXYrTXNJVnlEU2l6Zk1JSnJQZmpHZEFDek94bDhVZVUyOFVtSjg9</response>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:35 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:35 | [Mutex] received everything.

2020-06-25 23:45:35 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:35 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d6d2F2czAwMjgscj1Zd09KZTVnNEc0S1A0UTJxMkxuVA==</auth>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Zd09KZTVnNEc0S1A0UTJxMkxuVEJqS0VKVFZCeGdPYnpjMTNCYk1zLHM9VE9sTjVOK1JWS09OZ1E9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WXdPSmU1ZzRHNEtQNFEycTJMblRCaktFSlRWQnhnT2J6YzEzQmJNcyxwPXhhNm85a2QyZVNMaGtVSzZUVnJPQ1JMaVExOExKMGM3cG9TSk83MTYybGM9</response>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:35 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:35 | [Mutex] received everything.

2020-06-25 23:45:35 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:35 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d6d2F2czAwMjgscj05WFlGczBCV1I4elQ3UG1ndWFHeQ==</auth>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05WFlGczBCV1I4elQ3UG1ndWFHeVpsdG5TcFdWemxLWGJyQUZ4aUNvLHM9VE9sTjVOK1JWS09OZ1E9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OVhZRnMwQldSOHpUN1BtZ3VhR3labHRuU3BXVnpsS1hickFGeGlDbyxwPU1aYnRTR0h0Rkl4RlBrVU5QUklaMmNoT243d1lrK0pTOGp1ODNiZEJoWDQ9</response>

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:35 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:35 | [Mutex] received everything.

2020-06-25 23:45:35 | [Mutex] isItemNotified: authFailed :: true

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

2020-06-25 23:45:35 | user :: user_gzwavs0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:36 | user :: user_gzwavs0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d6d2F2czAwMjgscj1tZHg4VFlNTk1LOFJEdFZ1ZmNoOA==</auth>

2020-06-25 23:45:36 | user :: user_gzwavs0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tZHg4VFlNTk1LOFJEdFZ1ZmNoOE10WHJjUnhoNmtNRFhObEVPRGdPLHM9VE9sTjVOK1JWS09OZ1E9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:36 | user :: user_gzwavs0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bWR4OFRZTU5NSzhSRHRWdWZjaDhNdFhyY1J4aDZrTURYTmxFT0RnTyxwPVphVUkrQk9LeTFUaUVPMm9zek0zMmp0WDNPdWZ4TVRWNitEcERaK3dnMkU9</response>

2020-06-25 23:45:36 | user :: user_gzwavs0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:38 | [Mutex] waiting for: [user]

2020-06-25 23:45:38 | [Mutex] received everything.

2020-06-25 23:45:38 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.145s
2020-06-25 23:45:38 |

2020-06-25 23:45:38 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-06-25 23:45:38 | ------------------------------------

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@543ec670

2020-06-25 23:45:38 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29537d53}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5af92287}, 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@5ec6ad00}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1bc428bc}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@39eb60f2}, 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=Thu Jun 25 23:45:38 PDT 2020}}}}

2020-06-25 23:45:38 | [Mutex] waiting for: [registration]

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2a959052

2020-06-25 23:45:38 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5af92287}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@5ec6ad00}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1bc428bc}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@39eb60f2}, 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=Thu Jun 25 23:45:38 PDT 2020}}}}

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@415086ad

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

2020-06-25 23:45:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7bebd7f3}

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

2020-06-25 23:45:38 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-06-25 23:45:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1965d48c

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1f74d0f2

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

2020-06-25 23:45:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5a54485f}

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

2020-06-25 23:45:38 | user :: null >> <iq to="localhost" id="feVQV0s1hzygUZpOGO7xp05" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-06-25 23:45:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d98cdad2}

2020-06-25 23:45:38 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="feVQV0s1hzygUZpOGO7xp05"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x xmlns="jabber:x:data" type="form"><title>Account Registration</title><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field var="username" type="text-single" label="Username"><required/><value/></field><field var="password" type="text-private" label="Password"><required/><value/></field><field var="email" type="text-single" label="Email (MUST BE VALID!)"><required/><value/></field></x></query></iq>

2020-06-25 23:45:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7fa548a9}

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@48d33265

2020-06-25 23:45:38 | user :: null >> <iq to="localhost" id="4ondV0cvoW4iLQIFuqX9j2e" type="set"><query xmlns="jabber:iq:register"><username>user_qg87qt0029</username><password>user_qg87qt0029</password><email>3b574ebd-6ffc-40f6-acd8-2d24b2c73b17@localhost</email></query></iq>

2020-06-25 23:45:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8a208f67}

2020-06-25 23:45:38 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="4ondV0cvoW4iLQIFuqX9j2e"/>

2020-06-25 23:45:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@711998cd}

2020-06-25 23:45:38 | [Mutex] received everything.

2020-06-25 23:45:38 | [Mutex] isItemNotified: registrationSuccess :: true

2020-06-25 23:45:38 | 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;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7bebd7f3, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5a54485f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5af92287}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@5ec6ad00}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1bc428bc}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@39eb60f2}, 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=Thu Jun 25 23:45:38 PDT 2020}}}}

2020-06-25 23:45:38 | 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;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7bebd7f3, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5a54485f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5af92287}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@5ec6ad00}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1bc428bc}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@39eb60f2}, 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=Thu Jun 25 23:45:38 PDT 2020}}}}

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@9772001

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@5cc2d186

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@dd39061

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3031aee6

2020-06-25 23:45:38 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@76e7c9

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

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3FnODdxdDAwMjkscj1JQll0UHU0ck0xTGhZaG5tWDRKWA==</auth>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JQll0UHU0ck0xTGhZaG5tWDRKWDFBRzZpeWtmSmd1ZkhuN0JobWNtLHM9RWJSMkdVdVBoS05KMEE9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SUJZdFB1NHJNMUxoWWhubVg0SlgxQUc2aXlrZkpndWZIbjdCaG1jbSxwPTFWbHFhYWJub2p0SE5ZNFpsNDhkQUFTMHZVK21hWHVhVlNFeGFDQkdicGM9</response>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1scy93QVFQSjJ4eVlFbHdibUJ3LzU1Y2g1b1VYcnpWMGZOZmNTaGhPTTlNPQ==</success>

2020-06-25 23:45:38 | user :: user_qg87qt0029@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" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="fVdfIcSHLKursFAIaH8vkALmkEg="/></features>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost >> <iq xmlns="jabber:client" id="D6t6j0awczsW7oeznLW2s5B" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost << <iq xmlns="jabber:client" to="user_qg87qt0029@localhost/2095755800-tigase-25" type="result" id="D6t6j0awczsW7oeznLW2s5B"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_qg87qt0029@localhost/2095755800-tigase-25</jid></bind></iq>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost/2095755800-tigase-25 >> <iq xmlns="jabber:client" id="d7u7y8vaMFz9IAyhZY0sp7z" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost/2095755800-tigase-25 << <iq xmlns="jabber:client" to="user_qg87qt0029@localhost/2095755800-tigase-25" type="result" id="d7u7y8vaMFz9IAyhZY0sp7z"/>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost/2095755800-tigase-25 >> <iq to="localhost" id="whWbybP9NKGtkOOMJMApYoT" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost/2095755800-tigase-25 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost/2095755800-tigase-25 << <enabled xmlns="urn:xmpp:sm:3" max="60" location="9585556aacac" resume="true" id="b5a87c48-3e11-445c-aa20-04fc3652a48c"/>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost/2095755800-tigase-25 >> <iq id="1k3gBFP9s6j0awczsW7oezn" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost/2095755800-tigase-25 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost/2095755800-tigase-25 << <iq from="localhost" xmlns="jabber:client" to="user_qg87qt0029@localhost/2095755800-tigase-25" type="result" id="whWbybP9NKGtkOOMJMApYoT"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10776/960d5e95"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10776/960d5e95"/><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="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost/2095755800-tigase-25 << <iq xmlns="jabber:client" to="user_qg87qt0029@localhost/2095755800-tigase-25" type="result" id="1k3gBFP9s6j0awczsW7oezn"><query xmlns="jabber:iq:roster"/></iq>

2020-06-25 23:45:38 | Disconnecting

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost/2095755800-tigase-25 << <presence xmlns="jabber:client" from="user_qg87qt0029@localhost/2095755800-tigase-25" to="user_qg87qt0029@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-06-25 23:45:38 | [Mutex] notify: [disconnected]

2020-06-25 23:45:38 | [Mutex] received everything.

2020-06-25 23:45:38 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfcWc4N3F0MDAyOQAgLSAtIC0gLSAt</auth>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:38 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:38 | [Mutex] received everything.

2020-06-25 23:45:38 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:38 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfcWc4N3F0MDAyOQAgLSAtIC0gLSAt</auth>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:38 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:38 | [Mutex] received everything.

2020-06-25 23:45:38 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:38 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3FnODdxdDAwMjkscj1HbUN0bElEQnRyUVQyNHdnaWNidQ==</auth>

2020-06-25 23:45:38 | user :: user_qg87qt0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HbUN0bElEQnRyUVQyNHdnaWNidWwxQkUzV1BRc0xNN3FDVFc3RUZpLHM9MXdoMTRYMm03ckY5MEE9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R21DdGxJREJ0clFUMjR3Z2ljYnVsMUJFM1dQUXNMTTdxQ1RXN0VGaSxwPW1ucGhid0IrcEY0ME5pV3BINmdYYnk1NE5yWT0=</response>

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:39 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:39 | [Mutex] received everything.

2020-06-25 23:45:39 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:39 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3FnODdxdDAwMjkscj1tNzdqdUdUWVVMVk96M2RsTXNldQ==</auth>

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tNzdqdUdUWVVMVk96M2RsTXNldXBpV251d2h6M2Y5YU9aQ0QyWFZWLHM9RWJSMkdVdVBoS05KMEE9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bTc3anVHVFlVTFZPejNkbE1zZXVwaVdudXdoejNmOWFPWkNEMlhWVixwPXNSMHBJaVBDSldTdTNlTXRROUVIbzBCN0g2V3JyNGtjcjd5SmNuWEluTnM9</response>

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:39 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:39 | [Mutex] received everything.

2020-06-25 23:45:39 | [Mutex] isItemNotified: authFailed :: true

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

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3FnODdxdDAwMjkscj1vY1B5THZMSlJKSDZqWnZ5cEhkRA==</auth>

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vY1B5THZMSlJKSDZqWnZ5cEhkRHBxbWdycHI1blFGcUJoSzJFS095LHM9RWJSMkdVdVBoS05KMEE9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b2NQeUx2TEpSSkg2alp2eXBIZERwcW1ncnByNW5RRnFCaEsyRUtPeSxwPUdjMjRhWnRqSDM2bWF3Vi9BVEd1dkVKTTRhbVRSa2dCQ0NtOWFwdmdvVFk9</response>

2020-06-25 23:45:39 | user :: user_qg87qt0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:41 | [Mutex] waiting for: [user]

2020-06-25 23:45:41 | [Mutex] received everything.

2020-06-25 23:45:41 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.171s
2020-06-25 23:45:41 |

2020-06-25 23:45:41 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-06-25 23:45:41 | ------------------------------------

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6be81451

2020-06-25 23:45:41 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29537d53}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@652fe75c}, 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@61107f21}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2412ed67}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f732f28}, 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=Thu Jun 25 23:45:41 PDT 2020}}}}

2020-06-25 23:45:41 | [Mutex] waiting for: [registration]

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@15fc2c9d

2020-06-25 23:45:41 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@652fe75c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@61107f21}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2412ed67}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f732f28}, 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=Thu Jun 25 23:45:41 PDT 2020}}}}

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@7777b074

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

2020-06-25 23:45:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@443d1228}

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

2020-06-25 23:45:41 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-06-25 23:45:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@52217fe8

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@264d29f5

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

2020-06-25 23:45:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6c73d958}

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

2020-06-25 23:45:41 | user :: null >> <iq to="localhost" id="4vvspY8n8q2eDAcDqiHDhY6" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-06-25 23:45:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@627dfc5f}

2020-06-25 23:45:41 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="4vvspY8n8q2eDAcDqiHDhY6"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x xmlns="jabber:x:data" type="form"><title>Account Registration</title><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field var="username" type="text-single" label="Username"><required/><value/></field><field var="password" type="text-private" label="Password"><required/><value/></field><field var="email" type="text-single" label="Email (MUST BE VALID!)"><required/><value/></field></x></query></iq>

2020-06-25 23:45:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@40732aac}

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@19f4d375

2020-06-25 23:45:41 | user :: null >> <iq to="localhost" id="NiQN2bBdQQ4j36gYrbHAfXp" type="set"><query xmlns="jabber:iq:register"><username>user_q6eqqd0030</username><password>user_q6eqqd0030</password><email>dc7f9c5d-8f6f-49fd-83ee-ec473e64af90@localhost</email></query></iq>

2020-06-25 23:45:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@39120fa2}

2020-06-25 23:45:41 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="NiQN2bBdQQ4j36gYrbHAfXp"/>

2020-06-25 23:45:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5639433f}

2020-06-25 23:45:41 | [Mutex] received everything.

2020-06-25 23:45:41 | [Mutex] isItemNotified: registrationSuccess :: true

2020-06-25 23:45:41 | 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;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@443d1228, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6c73d958]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@652fe75c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@61107f21}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2412ed67}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f732f28}, 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=Thu Jun 25 23:45:41 PDT 2020}}}}

2020-06-25 23:45:41 | 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;@29537d53}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@443d1228, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6c73d958]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@652fe75c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@686e7768}, 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@61107f21}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2412ed67}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f732f28}, 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=Thu Jun 25 23:45:41 PDT 2020}}}}

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2472e9b9

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7d0d91d1

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@425d9a7e

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5ee119b1

2020-06-25 23:45:41 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@6ded0cf5

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

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3E2ZXFxZDAwMzAscj1lb1puVXltZmp6N2ExbTBJUnRWaQ==</auth>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lb1puVXltZmp6N2ExbTBJUnRWaVNxWk1LY0pmM01pa3dDNFN0TlQ4LHM9SmI3WWdZc2I3YktickE9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZW9ablV5bWZqejdhMW0wSVJ0VmlTcVpNS2NKZjNNaWt3QzRTdE5UOCxwPXF2aUkrd0RDV0trQ2NQYk92QUNNZFYvZDdCdGdBWXJRbmowQytPTGV0OFE9</response>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1UYU41Q3lUbWxtQnZoTDljV25UUU01MjY0QUFuVGpIME5maWNpTzRBU0pjPQ==</success>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@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" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="fVdfIcSHLKursFAIaH8vkALmkEg="/></features>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost >> <iq xmlns="jabber:client" id="rvrPISfNV29L1xeEpcyiKFE" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost << <iq xmlns="jabber:client" to="user_q6eqqd0030@localhost/2095755800-tigase-26" type="result" id="rvrPISfNV29L1xeEpcyiKFE"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_q6eqqd0030@localhost/2095755800-tigase-26</jid></bind></iq>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost/2095755800-tigase-26 >> <iq xmlns="jabber:client" id="yhJurnfEu5ygIAl02jM07tX" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost/2095755800-tigase-26 << <iq xmlns="jabber:client" to="user_q6eqqd0030@localhost/2095755800-tigase-26" type="result" id="yhJurnfEu5ygIAl02jM07tX"/>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost/2095755800-tigase-26 >> <iq to="localhost" id="RlTKUYkP5aoeXdLIvtrnU07" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost/2095755800-tigase-26 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost/2095755800-tigase-26 << <enabled xmlns="urn:xmpp:sm:3" max="60" location="9585556aacac" resume="true" id="7e4e9e78-9719-49e2-a941-eb041978b10a"/>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost/2095755800-tigase-26 >> <iq id="yjLyzDLGydOMKEtgylQ8nZZ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost/2095755800-tigase-26 << <iq from="localhost" xmlns="jabber:client" to="user_q6eqqd0030@localhost/2095755800-tigase-26" type="result" id="RlTKUYkP5aoeXdLIvtrnU07"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10776/960d5e95"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10776/960d5e95"/><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="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost/2095755800-tigase-26 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost/2095755800-tigase-26 << <iq xmlns="jabber:client" to="user_q6eqqd0030@localhost/2095755800-tigase-26" type="result" id="yjLyzDLGydOMKEtgylQ8nZZ"><query xmlns="jabber:iq:roster"/></iq>

2020-06-25 23:45:41 | Disconnecting

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost/2095755800-tigase-26 << <presence xmlns="jabber:client" from="user_q6eqqd0030@localhost/2095755800-tigase-26" to="user_q6eqqd0030@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-06-25 23:45:41 | [Mutex] notify: [disconnected]

2020-06-25 23:45:41 | [Mutex] received everything.

2020-06-25 23:45:41 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3E2ZXFxZDAwMzAscj1Lbnc4QTI5UU9CVjAwakt1RzBzVA==</auth>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Lbnc4QTI5UU9CVjAwakt1RzBzVG1aYlQ0RDJMWGJKS01FUHJrSEFnLHM9SmI3WWdZc2I3YktickE9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S253OEEyOVFPQlYwMGpLdUcwc1RtWmJUNEQyTFhiSktNRVBya0hBZyxwPW92R1hvcmJkMlBRZk9hTzNKdlNGcXR3MkVlZTFXNEF0ZmNON1ZORHhoeVk9</response>

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:41 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:41 | [Mutex] received everything.

2020-06-25 23:45:41 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:41 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:41 | user :: user_q6eqqd0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3E2ZXFxZDAwMzAscj1pWmtKZEFObHVIQzc1QnR6TWNCeQ==</auth>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pWmtKZEFObHVIQzc1QnR6TWNCeTE1SGN2NlQ5ZVBGaWRFR085aEVULHM9SmI3WWdZc2I3YktickE9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aVprSmRBTmx1SEM3NUJ0ek1jQnkxNUhjdjZUOWVQRmlkRUdPOWhFVCxwPXZhSXZqeXhIUjFuMHY5WmVwS0RraklCdTUvak5mekNnTE5MOTNFRVNCcDg9</response>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:42 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:42 | [Mutex] received everything.

2020-06-25 23:45:42 | [Mutex] isItemNotified: authFailed :: true

2020-06-25 23:45:42 | [Mutex] waiting for: [event]

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

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3E2ZXFxZDAwMzAscj0yMGI4YzFJNkdlOUUwTkRJSFlYYw==</auth>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yMGI4YzFJNkdlOUUwTkRJSFlYYzFkMGhVZjJ5WTR4VllBQVV3a1V3LHM9SmI3WWdZc2I3YktickE9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MjBiOGMxSTZHZTlFME5ESUhZWGMxZDBoVWYyeVk0eFZZQUFVd2tVdyxwPXFlTEJQZy9oWW50eDV2N2F5KzdaNlpUL254RWlWbG4yZ0k0ZUExamJiZGs9</response>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-06-25 23:45:42 | [Mutex] notify: [event, authFailed]

2020-06-25 23:45:42 | [Mutex] received everything.

2020-06-25 23:45:42 | [Mutex] isItemNotified: authFailed :: true

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

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3E2ZXFxZDAwMzAscj1EcFJMbGxZRE52Rm5UVlRWaVYwUw==</auth>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EcFJMbGxZRE52Rm5UVlRWaVYwU25WbkFFZkk2QmNmYkR2RFJpMUFQLHM9SmI3WWdZc2I3YktickE9PSxpPTQwOTY=</challenge>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RHBSTGxsWUROdkZuVFZUVmlWMFNuVm5BRWZJNkJjZmJEdkRSaTFBUCxwPUdndmQvZzJTSThFcXVycjlycjlVbzF2L25Bd0FHWS9mQ2JMS0JoNk16ZGs9</response>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj12Z0hJaW9KaWJTdDMzK0V2K3BCNUNwMVpkeXA4c2NwMzl2blFldnl4aWNjPQ==</success>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@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" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="fVdfIcSHLKursFAIaH8vkALmkEg="/></features>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost >> <iq xmlns="jabber:client" id="CDHvcvoW4iLQIFuqX9j2eQR" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost << <iq xmlns="jabber:client" to="user_q6eqqd0030@localhost/2095755800-tigase-27" type="result" id="CDHvcvoW4iLQIFuqX9j2eQR"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_q6eqqd0030@localhost/2095755800-tigase-27</jid></bind></iq>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost/2095755800-tigase-27 >> <iq xmlns="jabber:client" id="Fgyr2gGxoORScvfvq0oXlGq" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost/2095755800-tigase-27 << <iq xmlns="jabber:client" to="user_q6eqqd0030@localhost/2095755800-tigase-27" type="result" id="Fgyr2gGxoORScvfvq0oXlGq"/>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost/2095755800-tigase-27 >> <iq to="localhost" id="mbhV0oXlGqi5thKzBHTW4fS" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost/2095755800-tigase-27 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost/2095755800-tigase-27 << <enabled xmlns="urn:xmpp:sm:3" max="60" location="9585556aacac" resume="true" id="40c87337-448c-487d-b9fb-e01089d84b8b"/>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost/2095755800-tigase-27 >> <iq id="FiAvawczsW7oeznLW2s5Bcs" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost/2095755800-tigase-27 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost/2095755800-tigase-27 << <iq from="localhost" xmlns="jabber:client" to="user_q6eqqd0030@localhost/2095755800-tigase-27" type="result" id="mbhV0oXlGqi5thKzBHTW4fS"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10776/960d5e95"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10776/960d5e95"/><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="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost/2095755800-tigase-27 << <iq xmlns="jabber:client" to="user_q6eqqd0030@localhost/2095755800-tigase-27" type="result" id="FiAvawczsW7oeznLW2s5Bcs"><query xmlns="jabber:iq:roster"/></iq>

2020-06-25 23:45:42 | Disconnecting

2020-06-25 23:45:42 | user :: user_q6eqqd0030@localhost/2095755800-tigase-27 << <presence xmlns="jabber:client" from="user_q6eqqd0030@localhost/2095755800-tigase-27" to="user_q6eqqd0030@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-06-25 23:45:42 | [Mutex] notify: [disconnected]

2020-06-25 23:45:42 | [Mutex] received everything.

2020-06-25 23:45:44 | [Mutex] waiting for: [user]

2020-06-25 23:45:44 | [Mutex] received everything.

2020-06-25 23:45:44 | [Mutex] isItemNotified: user:ok:true :: true