Brute Force Prevention

Test duration: 15.590s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.766s
2020-05-25 22:31:10 |

2020-05-25 22:31:10 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-05-25 22:31:10 | ------------------------------------

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4de262aa

2020-05-25 22:31:10 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@960adae}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@43258566}, 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@471a09da}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2188f5d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c314a86}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:10 PDT 2020}}}}

2020-05-25 22:31:10 | [Mutex] waiting for: [registration]

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3350ead3

2020-05-25 22:31:10 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@43258566}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@471a09da}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2188f5d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c314a86}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:10 PDT 2020}}}}

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@249371ba

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

2020-05-25 22:31:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@62377012}

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

2020-05-25 22:31:10 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-05-25 22:31:10 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@340473a8

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@361189

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

2020-05-25 22:31:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3f97be94}

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

2020-05-25 22:31:10 | user :: null >> <iq to="localhost" id="HqxqhMQUcOP1p6EzydMV7CJ" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-05-25 22:31:10 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ecd2a311}

2020-05-25 22:31:10 | user :: null << <iq xmlns="jabber:client" id="HqxqhMQUcOP1p6EzydMV7CJ" from="localhost" type="result"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (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" label="Username" type="text-single"><required/><value/></field><field var="password" label="Password" type="text-private"><required/><value/></field><field var="email" label="Email (MUST BE VALID!)" type="text-single"><required/><value/></field></x></query></iq>

2020-05-25 22:31:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6679ee94}

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@717748c0

2020-05-25 22:31:10 | user :: null >> <iq to="localhost" id="UGhWZk1j0vlYW9tX8gJIx6A" type="set"><query xmlns="jabber:iq:register"><username>user_3yz6090027</username><password>user_3yz6090027</password><email>40f64829-5fce-4da5-9f09-e5f695594eeb@localhost</email></query></iq>

2020-05-25 22:31:10 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ddbd0d31}

2020-05-25 22:31:10 | user :: null << <iq xmlns="jabber:client" id="UGhWZk1j0vlYW9tX8gJIx6A" from="localhost" type="result"/>

2020-05-25 22:31:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@41fdb53e}

2020-05-25 22:31:10 | [Mutex] received everything.

2020-05-25 22:31:10 | [Mutex] isItemNotified: registrationSuccess :: true

2020-05-25 22:31:10 | 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;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@62377012, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3f97be94]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@43258566}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@471a09da}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2188f5d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c314a86}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:10 PDT 2020}}}}

2020-05-25 22:31:10 | 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;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@62377012, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3f97be94]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@43258566}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@471a09da}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2188f5d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c314a86}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:10 PDT 2020}}}}

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@431cd08b

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6ab89b32

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@21c2ffed

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@dbafaae

2020-05-25 22:31:10 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2887fb1a

2020-05-25 22:31:10 | user :: user_3yz6090027@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-05-25 22:31:10 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1GOGFCd0RUc25XWFpMREl5UTAxeA==</auth>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GOGFCd0RUc25XWFpMREl5UTAxeE11cTdSRVJCd3FyWVpycGVVakE3LHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RjhhQndEVHNuV1haTERJeVEwMXhNdXE3UkVSQndxcllacnBlVWpBNyxwPVoxNVF6aFY4bU9JWjRRRXVtajF5ZTY1UHhDQU5QNzIwcnlGbnYxc0tHNUU9</response>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1BbEZ5M1BmbE5UQ2dDdVZkUjhxT25lTVRsNzVUYW9TQ0dlUG13TU1BeWRzPQ==</success>

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

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <iq xmlns="jabber:client" id="wLuesbx5oMLMFm6DugKSaxr" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <iq xmlns="jabber:client" id="wLuesbx5oMLMFm6DugKSaxr" type="result" to="user_3yz6090027@localhost/2095755800-tigase-19"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_3yz6090027@localhost/2095755800-tigase-19</jid></bind></iq>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost/2095755800-tigase-19 >> <iq xmlns="jabber:client" id="SJm8xu5wp5yBxmIHz9w2hOJ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost/2095755800-tigase-19 << <iq xmlns="jabber:client" id="SJm8xu5wp5yBxmIHz9w2hOJ" type="result" to="user_3yz6090027@localhost/2095755800-tigase-19"/>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost/2095755800-tigase-19 >> <iq to="localhost" id="7svbClIO3kW6AAn7Buq7Epa" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost/2095755800-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost/2095755800-tigase-19 << <enabled resume="true" xmlns="urn:xmpp:sm:3" id="cddfc3d8-4e25-449b-9f36-bd5dc6b219bc" max="60" location="9585556aacac"/>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost/2095755800-tigase-19 >> <iq id="YQDvohT48xfves7u5cMZcGA" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost/2095755800-tigase-19 << <iq xmlns="jabber:client" id="7svbClIO3kW6AAn7Buq7Epa" from="localhost" type="result" to="user_3yz6090027@localhost/2095755800-tigase-19"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost/2095755800-tigase-19 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost/2095755800-tigase-19 << <iq xmlns="jabber:client" id="YQDvohT48xfves7u5cMZcGA" type="result" to="user_3yz6090027@localhost/2095755800-tigase-19"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 22:31:11 | Disconnecting

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost/2095755800-tigase-19 << <presence xmlns="jabber:client" from="user_3yz6090027@localhost/2095755800-tigase-19" to="user_3yz6090027@localhost"><c node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-05-25 22:31:11 | [Mutex] notify: [disconnected]

2020-05-25 22:31:11 | [Mutex] received everything.

2020-05-25 22:31:11 | [Mutex] waiting for: [event]

2020-05-25 22:31:11 | user :: user_3yz6090027@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-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1obmtIaEJjQm1wN0dKRzJ3b0h1UQ==</auth>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1obmtIaEJjQm1wN0dKRzJ3b0h1UUltaDg5YmxJb3pOVThPdDlXVTl3LHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aG5rSGhCY0JtcDdHSkcyd29IdVFJbWg4OWJsSW96TlU4T3Q5V1U5dyxwPXJmM2NGQ1BIM3ZzcER5anVGb2x2QjZocG5MK3V3OFdkUWRxL2dzSWgrSVE9</response>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:11 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:11 | [Mutex] notify: [event, disconnected]

2020-05-25 22:31:11 | [Mutex] received everything.

2020-05-25 22:31:11 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:11 | [Mutex] waiting for: [event]

2020-05-25 22:31:11 | user :: user_3yz6090027@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-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj15TUIweDBMdFVGbklwRFVXamtqYg==</auth>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15TUIweDBMdFVGbklwRFVXamtqYndIWUVTMWJQTlJuQ3RybEYzS3BCLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eU1CMHgwTHRVRm5JcERVV2pramJ3SFlFUzFiUE5SbkN0cmxGM0twQixwPWcrUmJJeXY2UkhLK2J4emhFZTUzYm1qZU5YdFA5aFBpOGZsMkhORDZ2R0k9</response>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:11 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:11 | [Mutex] received everything.

2020-05-25 22:31:11 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:11 | [Mutex] waiting for: [event]

2020-05-25 22:31:11 | user :: user_3yz6090027@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-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1Va0xub2JwcEkxQ2dqbVhNZnlycA==</auth>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Va0xub2JwcEkxQ2dqbVhNZnlycDh3SzRVbHJQRzBFQmJFRkFBUklhLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VWtMbm9icHBJMUNnam1YTWZ5cnA4d0s0VWxyUEcwRUJiRUZBQVJJYSxwPWJELzM3S09menlkQXpmWjA0VGRSS0Nvd2dCM2xleUtsSGF5dUg0TTVVdkE9</response>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:11 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:11 | [Mutex] received everything.

2020-05-25 22:31:11 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:11 | [Mutex] waiting for: [event]

2020-05-25 22:31:11 | user :: user_3yz6090027@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-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1ZTFF6bDYyZElHcTRieTZuUVBBQw==</auth>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZTFF6bDYyZElHcTRieTZuUVBBQ3RlNzZaRVBPZE4waGNUTVRKdjFFLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WUxRemw2MmRJR3E0Ynk2blFQQUN0ZTc2WkVQT2ROMGhjVE1USnYxRSxwPVc4SkhqZmxwL05SM2FxNDI1SUJTam1va0ViTERLRWZBRjVreDBpTWV2a0k9</response>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:11 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:11 | [Mutex] received everything.

2020-05-25 22:31:11 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:11 | [Mutex] waiting for: [event]

2020-05-25 22:31:11 | user :: user_3yz6090027@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-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj10UjQyMjRUVVI4NmFqSGZ2em1uSQ==</auth>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10UjQyMjRUVVI4NmFqSGZ2em1uSWU5WE1mZGZmcnFtTVpPM000Q09yLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFI0MjI0VFVSODZhakhmdnptbkllOVhNZmRmZnJxbU1aTzNNNENPcixwPXM0NmN3QTQrLzdXelFPRHFORTBXa2tTR0RGbzNsS2NLSDA3TDdJSFBwTEU9</response>

2020-05-25 22:31:11 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:11 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:11 | [Mutex] received everything.

2020-05-25 22:31:11 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:11 | [Mutex] waiting for: [event]

2020-05-25 22:31:11 | user :: user_3yz6090027@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-05-25 22:31:11 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj0xQjI1VFI5R053bnFJVEhMQ3N5WA==</auth>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xQjI1VFI5R053bnFJVEhMQ3N5WHdpOWhoNjc5aks5Q012ZWh3bTRNLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MUIyNVRSOUdOd25xSVRITENzeVh3aTloaDY3OWpLOUNNdmVod200TSxwPWt6MW1zWnhaYUtmanF4TEdQeWxFUFRLTVFHSUpZcnVHQ3Q4c3Rwbm1VM2M9</response>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:12 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:12 | [Mutex] notify: [event, disconnected]

2020-05-25 22:31:12 | [Mutex] received everything.

2020-05-25 22:31:12 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:12 | [Mutex] waiting for: [event]

2020-05-25 22:31:12 | user :: user_3yz6090027@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-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1ZajBiVVA0R3dDTzVJRHRvdzB6dg==</auth>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZajBiVVA0R3dDTzVJRHRvdzB6dms2Q0VBeGFYYkUzbHYzV1FxWk1FLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WWowYlVQNEd3Q081SUR0b3cwenZrNkNFQXhhWGJFM2x2M1dRcVpNRSxwPUdHRWhYRnJhZ2JZQ2V4cVBGZkJDL2hjV0sxTENvV09DaXE1Qm9Oa3YxeVk9</response>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:12 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:12 | [Mutex] received everything.

2020-05-25 22:31:12 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:12 | [Mutex] waiting for: [event]

2020-05-25 22:31:12 | user :: user_3yz6090027@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-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1PbU5BS0NiTGw5QWtuUjRhSkZudg==</auth>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PbU5BS0NiTGw5QWtuUjRhSkZudm5oNVlmdzhuYzZIU1ZaNmpvODMwLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T21OQUtDYkxsOUFrblI0YUpGbnZuaDVZZnc4bmM2SFNWWjZqbzgzMCxwPVpOS2dlTlJibmxGamtsUkxoTWl0RHFsNGNwMnJzVU0zSjZSeDZyZGt1cEk9</response>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:12 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:12 | [Mutex] notify: [event, disconnected]

2020-05-25 22:31:12 | [Mutex] received everything.

2020-05-25 22:31:12 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:12 | [Mutex] waiting for: [event]

2020-05-25 22:31:12 | user :: user_3yz6090027@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-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1neDB4MnVRZGZnM0tlS3lZWDc4dg==</auth>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1neDB4MnVRZGZnM0tlS3lZWDc4dnByZnVEdEdhWDJhRlo2YkYyY0JNLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z3gweDJ1UWRmZzNLZUt5WVg3OHZwcmZ1RHRHYVgyYUZaNmJGMmNCTSxwPWFnYlBjODBLUGY0UGNKODZQMGFiU09uc3lTOHhlTEo0QXZ1b0xlanhqRUk9</response>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:12 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:12 | [Mutex] received everything.

2020-05-25 22:31:12 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:12 | [Mutex] waiting for: [event]

2020-05-25 22:31:12 | user :: user_3yz6090027@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-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1ZRUZEZVpqdTJqbWtjOE9VQ2x0Ng==</auth>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZRUZEZVpqdTJqbWtjOE9VQ2x0NmlKa3VQaUJBWmNvMm1YZVppTk1lLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WUVGRGVaanUyam1rYzhPVUNsdDZpSmt1UGlCQVpjbzJtWGVaaU5NZSxwPWd6YVBmanFkYmE1QUJYY2ZuSFZ3ZEZzV3BPRmFrUlNka0xSbTRwcW4yaVU9</response>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:12 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:12 | [Mutex] received everything.

2020-05-25 22:31:12 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:12 | [Mutex] waiting for: [event]

2020-05-25 22:31:12 | user :: user_3yz6090027@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-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1oWjg1czBZdE13cU9LZXFGUTNUSg==</auth>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oWjg1czBZdE13cU9LZXFGUTNUSkdUa1B2SXNXbWdjYWxXNExEeUtBLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aFo4NXMwWXRNd3FPS2VxRlEzVEpHVGtQdklzV21nY2FsVzRMRHlLQSxwPUxXejdSSEtjOUZrT2FTaHBKNkYzNVZvL0FrUWtxRzhhclloSUorT2VwWFk9</response>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:12 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:12 | [Mutex] received everything.

2020-05-25 22:31:12 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:12 | [Mutex] waiting for: [event]

2020-05-25 22:31:12 | user :: user_3yz6090027@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-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1PaHI4clRxcjBUWnB6YjBnMFdEVg==</auth>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PaHI4clRxcjBUWnB6YjBnMFdEVjF4elpnOHdZTEE0U2hHUmhWOFl3LHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T2hyOHJUcXIwVFpwemIwZzBXRFYxeHpaZzh3WUxBNFNoR1JoVjhZdyxwPVRIeERUU2ZSS1hRNmpUTjZvOVZIUHNsL0xwRGxjOTZYL3dZKzArUnNaNHM9</response>

2020-05-25 22:31:12 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:12 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:12 | [Mutex] received everything.

2020-05-25 22:31:12 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:12 | [Mutex] waiting for: [event]

2020-05-25 22:31:12 | user :: user_3yz6090027@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-05-25 22:31:12 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1xaXhQeXRzV0U1cmd1NEtXVHdHUQ==</auth>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xaXhQeXRzV0U1cmd1NEtXVHdHUU1kOWF5bW10VWpUMHhvRmVKV09sLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cWl4UHl0c1dFNXJndTRLV1R3R1FNZDlheW1tdFVqVDB4b0ZlSldPbCxwPUNMRmxDeVNHeFN4UVBvOHJpVVNNWWh1SVRENG5rK1ZHYkRwQjUxRVpVMGs9</response>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:13 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:13 | [Mutex] received everything.

2020-05-25 22:31:13 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:13 | [Mutex] waiting for: [event]

2020-05-25 22:31:13 | user :: user_3yz6090027@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-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj16SDlKTEtDUjYwSmpHem5rMzlqNQ==</auth>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16SDlKTEtDUjYwSmpHem5rMzlqNVV3bXlwRHgxRWZVWEhXNlI5VTJ0LHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ekg5SkxLQ1I2MEpqR3puazM5ajVVd215cER4MUVmVVhIVzZSOVUydCxwPW5WNTBpZDhrNFpMd05weE5GWDA5blp5TnpaelRpazVZanN2N3dlSlJEa3M9</response>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:13 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:13 | [Mutex] received everything.

2020-05-25 22:31:13 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:13 | [Mutex] waiting for: [event]

2020-05-25 22:31:13 | user :: user_3yz6090027@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-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj01UWFZU1RXYjhoS1c3b0trR2NKSQ==</auth>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01UWFZU1RXYjhoS1c3b0trR2NKSUE5TDFhNXo0eXFBNkp5MlFvT0lILHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NVFhWVNUV2I4aEtXN29La0djSklBOUwxYTV6NHlxQTZKeTJRb09JSCxwPVZ0VDVaQ3lrcERweHNIMHMvN1U4ci9ncFVxZUVIVFpROFVXL3N3R3hrTE09</response>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:13 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:13 | [Mutex] received everything.

2020-05-25 22:31:13 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:13 | [Mutex] waiting for: [event]

2020-05-25 22:31:13 | user :: user_3yz6090027@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-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1oVGtMU0pqQXBoTXN1Ym1IRzRLdA==</auth>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oVGtMU0pqQXBoTXN1Ym1IRzRLdEcxY3NBRkNQTU1CRVpGSW5qQ2pKLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aFRrTFNKakFwaE1zdWJtSEc0S3RHMWNzQUZDUE1NQkVaRkluakNqSixwPUMyQW40Y0xTNXdsWWtubTNCRVJKNTlGeU5sZVl3U0xDV3ZWZzl2NGpCRUU9</response>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:13 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:13 | [Mutex] received everything.

2020-05-25 22:31:13 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:13 | [Mutex] waiting for: [event]

2020-05-25 22:31:13 | user :: user_3yz6090027@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-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1QUUhDbVZ3RlJWazBjU1lQUGRUdA==</auth>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QUUhDbVZ3RlJWazBjU1lQUGRUdGxmSENOMHR3WUNseDdlbnFyZXNpLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UFFIQ21Wd0ZSVmswY1NZUFBkVHRsZkhDTjB0d1lDbHg3ZW5xcmVzaSxwPVV4WVNNWkR3Mm01KzcvWDFuSGljYlpYTkt2WlAyRVU3NFd1L2h2UDFENmc9</response>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:13 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:13 | [Mutex] received everything.

2020-05-25 22:31:13 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:13 | [Mutex] waiting for: [event]

2020-05-25 22:31:13 | user :: user_3yz6090027@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-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj02Y3RwczNHYVB3ZUs3eURLckVaVw==</auth>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02Y3RwczNHYVB3ZUs3eURLckVaV1NBUDJrRm40OUJ3N1hpRWo0SEV1LHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NmN0cHMzR2FQd2VLN3lES3JFWldTQVAya0ZuNDlCdzdYaUVqNEhFdSxwPWFWdnRJYlgwd2M1R1RvczlxR3FpVTBETjlkV3p4UmVtSnlVa2IraHN2ejg9</response>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:13 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:13 | [Mutex] received everything.

2020-05-25 22:31:13 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:13 | [Mutex] waiting for: [event]

2020-05-25 22:31:13 | user :: user_3yz6090027@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-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1GM2VzVkRKQ2FJWTFmWGpYVWxTMg==</auth>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GM2VzVkRKQ2FJWTFmWGpYVWxTMmNQOTBsenRMVDFDckRvNTM3NVVILHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RjNlc1ZESkNhSVkxZlhqWFVsUzJjUDkwbHp0TFQxQ3JEbzUzNzVVSCxwPUp4WGt5cERlYVR1S1orL0JRYWV4bVFmZE54SVFseDRpdnFFV0NtMUc0Z009</response>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:13 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:13 | [Mutex] received everything.

2020-05-25 22:31:13 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:13 | [Mutex] waiting for: [event]

2020-05-25 22:31:13 | user :: user_3yz6090027@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-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1kdTJZeThna3g2U1NUc0tZU1IzSQ==</auth>

2020-05-25 22:31:13 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kdTJZeThna3g2U1NUc0tZU1IzSWF0TlBtNzQ0MjFESmdteng2VUdULHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:14 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZHUyWXk4Z2t4NlNTVHNLWVNSM0lhdE5QbTc0NDIxREpnbXp4NlVHVCxwPWlSbFhNMTU1bW1RRHlGNVVwL3NVMVRCbzl3UzZLQnZDMThSczI1elQvSTg9</response>

2020-05-25 22:31:14 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:14 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:14 | [Mutex] received everything.

2020-05-25 22:31:14 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:14 | [Mutex] waiting for: [event]

2020-05-25 22:31:14 | user :: user_3yz6090027@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-05-25 22:31:14 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:14 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1ia0xMckNNZXAyMDA1SjZTNTNUcA==</auth>

2020-05-25 22:31:14 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ia0xMckNNZXAyMDA1SjZTNTNUcDlUMFE5UUg0UWNzc2dGNHRMYnZJLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:14 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YmtMTHJDTWVwMjAwNUo2UzUzVHA5VDBROVFINFFjc3NnRjR0TGJ2SSxwPTBmK3RGYzdkbkVLTFYvelFOejgrVko5OUplTVJsRUNKSWJDV25JQStwVkE9</response>

2020-05-25 22:31:14 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:14 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:14 | [Mutex] received everything.

2020-05-25 22:31:14 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:14 | user :: user_3yz6090027@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-05-25 22:31:14 | user :: user_3yz6090027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:14 | user :: user_3yz6090027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzN5ejYwOTAwMjcscj1SNmhxZEtrSDJEdmYyT1dPM0g2aQ==</auth>

2020-05-25 22:31:14 | user :: user_3yz6090027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SNmhxZEtrSDJEdmYyT1dPM0g2aU5IeVhlek9RMmM5TE5MTjVOWW5wLHM9WkFGekFuM0xRZWxla2c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:14 | user :: user_3yz6090027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UjZocWRLa0gyRHZmMk9XTzNINmlOSHlYZXpPUTJjOUxOTE41TllucCxwPUVQQjlyK085SjJnWXpqNGxmYUJVK3V6UTRrdmFSNmQxRm1pM2xUTkg1ckk9</response>

2020-05-25 22:31:14 | user :: user_3yz6090027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: user_3yz6090027@localhost is not authorized to act as user_3yz6090027@localhost</text></failure>

2020-05-25 22:31:16 | [Mutex] waiting for: [user]

2020-05-25 22:31:16 | [Mutex] received everything.

2020-05-25 22:31:16 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.180s
2020-05-25 22:31:16 |

2020-05-25 22:31:16 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-05-25 22:31:16 | ------------------------------------

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2b395f50

2020-05-25 22:31:16 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@960adae}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@25fea447}, 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@21c13420}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@64c3ae7c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e1ae6b}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:16 PDT 2020}}}}

2020-05-25 22:31:16 | [Mutex] waiting for: [registration]

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@556dee0c

2020-05-25 22:31:16 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@25fea447}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@21c13420}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@64c3ae7c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e1ae6b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:16 PDT 2020}}}}

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@7da5b0b5

2020-05-25 22:31:16 | 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-05-25 22:31:16 | 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-05-25 22:31:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ec5133}

2020-05-25 22:31:16 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-05-25 22:31:16 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@c763533

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3651a73f

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

2020-05-25 22:31:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@66a19958}

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

2020-05-25 22:31:16 | user :: null >> <iq to="localhost" id="dXSWayuoZl3oeJSR4vhWn5s" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-05-25 22:31:16 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@920a70e9}

2020-05-25 22:31:16 | user :: null << <iq xmlns="jabber:client" id="dXSWayuoZl3oeJSR4vhWn5s" from="localhost" type="result"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (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" label="Username" type="text-single"><required/><value/></field><field var="password" label="Password" type="text-private"><required/><value/></field><field var="email" label="Email (MUST BE VALID!)" type="text-single"><required/><value/></field></x></query></iq>

2020-05-25 22:31:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a22976}

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3dc04bfc

2020-05-25 22:31:16 | user :: null >> <iq to="localhost" id="9NmNCCFyo0ocBzvi2l6jYjT" type="set"><query xmlns="jabber:iq:register"><username>user_t0rnl70028</username><password>user_t0rnl70028</password><email>4ebe1915-99e8-4c4e-8aae-825124d916e3@localhost</email></query></iq>

2020-05-25 22:31:16 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@152f24c4}

2020-05-25 22:31:16 | user :: null << <iq xmlns="jabber:client" id="9NmNCCFyo0ocBzvi2l6jYjT" from="localhost" type="result"/>

2020-05-25 22:31:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6137b24}

2020-05-25 22:31:16 | [Mutex] received everything.

2020-05-25 22:31:16 | [Mutex] isItemNotified: registrationSuccess :: true

2020-05-25 22:31:16 | 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;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ec5133, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@66a19958]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@25fea447}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@21c13420}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@64c3ae7c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e1ae6b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:16 PDT 2020}}}}

2020-05-25 22:31:16 | 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;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ec5133, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@66a19958]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@25fea447}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@21c13420}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@64c3ae7c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e1ae6b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:16 PDT 2020}}}}

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6c9259e7

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7dea249a

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@424a0f70

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5f9d8646

2020-05-25 22:31:16 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@213ea133

2020-05-25 22:31:16 | user :: user_t0rnl70028@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-05-25 22:31:16 | user :: user_t0rnl70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Qwcm5sNzAwMjgscj1ZRmlmaHhZalZWVnVrVW5WMkVlMQ==</auth>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZRmlmaHhZalZWVnVrVW5WMkVlMUJJT3BPb3d6TFB4SjZxdFJVYWNOLHM9L3REb3dTUmdaUE0vSUE9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WUZpZmh4WWpWVlZ1a1VuVjJFZTFCSU9wT293ekxQeEo2cXRSVWFjTixwPTY3VzlZMnQ0akVxK1VpcitCQ21EUVJvOUVmNm9GZmVNUFBuU2VUV1ByNFk9</response>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1rUS9xdWhGVlcrb2NlYXU0MEtiNU11SUJXYnI4Z04vYS9xcGhvMjNrMDRRPQ==</success>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1" ver="z4E8/RbDarYCAPa9avxwCC7J86E="/></features>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost >> <iq xmlns="jabber:client" id="6MhwfKBeQ7scCCEvn7wufUV" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost << <iq xmlns="jabber:client" id="6MhwfKBeQ7scCCEvn7wufUV" type="result" to="user_t0rnl70028@localhost/2095755800-tigase-20"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_t0rnl70028@localhost/2095755800-tigase-20</jid></bind></iq>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost/2095755800-tigase-20 >> <iq xmlns="jabber:client" id="kWJNScFKBytdO7zqQX5bAax" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost/2095755800-tigase-20 << <iq xmlns="jabber:client" id="kWJNScFKBytdO7zqQX5bAax" type="result" to="user_t0rnl70028@localhost/2095755800-tigase-20"/>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost/2095755800-tigase-20 >> <iq to="localhost" id="5BGy6p4fwqhMQUcOP1p6Ezy" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost/2095755800-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost/2095755800-tigase-20 << <enabled resume="true" xmlns="urn:xmpp:sm:3" id="edf8d5c2-4921-4096-8b83-bc57ad506d3f" max="60" location="9585556aacac"/>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost/2095755800-tigase-20 >> <iq id="fTweQ6pbJKW9IxqdHM3rakV" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost/2095755800-tigase-20 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost/2095755800-tigase-20 << <iq xmlns="jabber:client" id="5BGy6p4fwqhMQUcOP1p6Ezy" from="localhost" type="result" to="user_t0rnl70028@localhost/2095755800-tigase-20"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost/2095755800-tigase-20 << <iq xmlns="jabber:client" id="fTweQ6pbJKW9IxqdHM3rakV" type="result" to="user_t0rnl70028@localhost/2095755800-tigase-20"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 22:31:16 | Disconnecting

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost/2095755800-tigase-20 << <presence xmlns="jabber:client" from="user_t0rnl70028@localhost/2095755800-tigase-20" to="user_t0rnl70028@localhost"><c node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-05-25 22:31:16 | [Mutex] notify: [disconnected]

2020-05-25 22:31:16 | [Mutex] received everything.

2020-05-25 22:31:16 | [Mutex] waiting for: [event]

2020-05-25 22:31:16 | user :: user_t0rnl70028@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-05-25 22:31:16 | user :: user_t0rnl70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Qwcm5sNzAwMjgscj1DVHpDS0dNaThEd01BMFdqRjB1cQ==</auth>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DVHpDS0dNaThEd01BMFdqRjB1cXJjYjdWbXppc2dpQ0dFVEJlaHNoLHM9L3REb3dTUmdaUE0vSUE9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q1R6Q0tHTWk4RHdNQTBXakYwdXFyY2I3Vm16aXNnaUNHRVRCZWhzaCxwPWJvKzMvWDBieWgvemNJRC9wd2srSnBDK1JONEdwSHVac1FVVHNBeGxkRmc9</response>

2020-05-25 22:31:16 | user :: user_t0rnl70028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:16 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:16 | [Mutex] received everything.

2020-05-25 22:31:16 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:16 | [Mutex] waiting for: [event]

2020-05-25 22:31:17 | user :: user_t0rnl70028@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-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Qwcm5sNzAwMjgscj1kYnVlYzRUc2oxc1lGaXlOU0NRVw==</auth>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kYnVlYzRUc2oxc1lGaXlOU0NRV1A4b3hia1M5cUQ3OVpoWUYzUkptLHM9L3REb3dTUmdaUE0vSUE9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZGJ1ZWM0VHNqMXNZRml5TlNDUVdQOG94YmtTOXFENzlaaFlGM1JKbSxwPTRlSEFoazFkQ0lXQldncWg5OTA0bUJvVTN4SnB4am0xUDZBczJzam5PREk9</response>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:17 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:17 | [Mutex] received everything.

2020-05-25 22:31:17 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:17 | [Mutex] notify: [event, disconnected]

2020-05-25 22:31:17 | [Mutex] waiting for: [event]

2020-05-25 22:31:17 | user :: user_t0rnl70028@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-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Qwcm5sNzAwMjgscj1iMkd0c29nbk9pTjFxVHRlZ0gxVg==</auth>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iMkd0c29nbk9pTjFxVHRlZ0gxVmdmdVBHOXd3cG9rNjVuUm1VbzlpLHM9L3REb3dTUmdaUE0vSUE9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YjJHdHNvZ25PaU4xcVR0ZWdIMVZnZnVQRzl3d3BvazY1blJtVW85aSxwPUZJdE5BM2JobDkrR2ZTWHltY3lHQTVSbDdpM0tLS243QUpjMmZZL1NSWDQ9</response>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:17 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:17 | [Mutex] received everything.

2020-05-25 22:31:17 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:17 | [Mutex] waiting for: [event]

2020-05-25 22:31:17 | user :: user_t0rnl70028@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-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Qwcm5sNzAwMjgscj0wSlBiQ1BWZjA1djF5WW5od2RwdA==</auth>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wSlBiQ1BWZjA1djF5WW5od2RwdDhuUndNdlYxOFVjWk5kck9RVHN1LHM9L3REb3dTUmdaUE0vSUE9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MEpQYkNQVmYwNXYxeVluaHdkcHQ4blJ3TXZWMThVY1pOZHJPUVRzdSxwPXkxQWFVOVhuSVlwZkVNdVF2ZnA5cUNuM1psWDVBUXUwU2RCV0c5Z3Y3bEU9</response>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:17 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:17 | [Mutex] received everything.

2020-05-25 22:31:17 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:17 | user :: user_t0rnl70028@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-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Qwcm5sNzAwMjgscj1WS1VhSXhzWjBJVFJ4ZnowMjJEdw==</auth>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WS1VhSXhzWjBJVFJ4ZnowMjJEd3ZVOXFyRU5sRHp6aUFnVFBWVURjLHM9L3REb3dTUmdaUE0vSUE9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VktVYUl4c1owSVRSeGZ6MDIyRHd2VTlxckVObER6emlBZ1RQVlVEYyxwPUM4UGo1bW5XR0E1MkZRaWcwU3Z3c08rcmZwRGVQYjZYTXV4UlgyVFlOSWM9</response>

2020-05-25 22:31:17 | user :: user_t0rnl70028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:19 | [Mutex] waiting for: [user]

2020-05-25 22:31:19 | [Mutex] received everything.

2020-05-25 22:31:19 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.194s
2020-05-25 22:31:19 |

2020-05-25 22:31:19 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-05-25 22:31:19 | ------------------------------------

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@68595fcd

2020-05-25 22:31:19 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@960adae}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@669ebcb6}, 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@62a134bd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@27a3b68d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5262283}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:19 PDT 2020}}}}

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@16ce559d

2020-05-25 22:31:19 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@669ebcb6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@62a134bd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@27a3b68d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5262283}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:19 PDT 2020}}}}

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@7da19f25

2020-05-25 22:31:19 | [Mutex] waiting for: [registration]

2020-05-25 22:31:19 | 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-05-25 22:31:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@478c49c2}

2020-05-25 22:31:19 | 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-05-25 22:31:19 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-05-25 22:31:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@738a598a

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@170c98db

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

2020-05-25 22:31:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@66a575a8}

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

2020-05-25 22:31:19 | user :: null >> <iq to="localhost" id="xWz6t7fIq3mPGKV4q4ws7Bz" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-05-25 22:31:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b0e03a60}

2020-05-25 22:31:19 | user :: null << <iq xmlns="jabber:client" id="xWz6t7fIq3mPGKV4q4ws7Bz" from="localhost" type="result"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (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" label="Username" type="text-single"><required/><value/></field><field var="password" label="Password" type="text-private"><required/><value/></field><field var="email" label="Email (MUST BE VALID!)" type="text-single"><required/><value/></field></x></query></iq>

2020-05-25 22:31:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@43c2f2e7}

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6225b51c

2020-05-25 22:31:19 | user :: null >> <iq to="localhost" id="GM36ABq8um8tjZgYdQNWfLU" type="set"><query xmlns="jabber:iq:register"><username>user_x81sqj0029</username><password>user_x81sqj0029</password><email>20f0af09-a3ce-4501-be39-2f3021777408@localhost</email></query></iq>

2020-05-25 22:31:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6604813c}

2020-05-25 22:31:19 | user :: null << <iq xmlns="jabber:client" id="GM36ABq8um8tjZgYdQNWfLU" from="localhost" type="result"/>

2020-05-25 22:31:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@119c23c3}

2020-05-25 22:31:19 | [Mutex] received everything.

2020-05-25 22:31:19 | [Mutex] isItemNotified: registrationSuccess :: true

2020-05-25 22:31:19 | 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;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@478c49c2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@66a575a8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@669ebcb6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@62a134bd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@27a3b68d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5262283}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:19 PDT 2020}}}}

2020-05-25 22:31:19 | 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;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@478c49c2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@66a575a8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@669ebcb6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@62a134bd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@27a3b68d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5262283}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:19 PDT 2020}}}}

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5c590c6d

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@85898cb

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@471a4189

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@37e8e092

2020-05-25 22:31:19 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2346a866

2020-05-25 22:31:19 | user :: user_x81sqj0029@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-05-25 22:31:19 | user :: user_x81sqj0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:19 | user :: user_x81sqj0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3g4MXNxajAwMjkscj1CbmNmR0cyR1FSbGxzRUFHNDdnUw==</auth>

2020-05-25 22:31:19 | user :: user_x81sqj0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CbmNmR0cyR1FSbGxzRUFHNDdnU2lIbVRvd0dxU29DQk80NDExQWIwLHM9eXJsR2xSOFd0QWN6a3c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:19 | user :: user_x81sqj0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Qm5jZkdHMkdRUmxsc0VBRzQ3Z1NpSG1Ub3dHcVNvQ0JPNDQxMUFiMCxwPUV1S3lsRmJHbUlLOGRDOTFoL0NjRDJWbWFRd0sxVWxCWFMra1V2N0s3cEE9</response>

2020-05-25 22:31:19 | user :: user_x81sqj0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj11dUlBdlc3UzhBRENUMjRrZDhma0pkcGcwV3d3K2tNcmdOVUZwQkdHaHdRPQ==</success>

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

2020-05-25 22:31:19 | user :: user_x81sqj0029@localhost >> <iq xmlns="jabber:client" id="5HMKubClIO3kW6AAn7Buq7E" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-05-25 22:31:19 | user :: user_x81sqj0029@localhost << <iq xmlns="jabber:client" id="5HMKubClIO3kW6AAn7Buq7E" type="result" to="user_x81sqj0029@localhost/2095755800-tigase-21"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_x81sqj0029@localhost/2095755800-tigase-21</jid></bind></iq>

2020-05-25 22:31:19 | user :: user_x81sqj0029@localhost/2095755800-tigase-21 >> <iq xmlns="jabber:client" id="w2LMynVRWSXarUcPS2iYmVd" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-05-25 22:31:19 | user :: user_x81sqj0029@localhost/2095755800-tigase-21 << <iq xmlns="jabber:client" id="w2LMynVRWSXarUcPS2iYmVd" type="result" to="user_x81sqj0029@localhost/2095755800-tigase-21"/>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost/2095755800-tigase-21 >> <iq to="localhost" id="8Vo07gUfIIEGMLT9ACvqXgT" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost/2095755800-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost/2095755800-tigase-21 << <enabled resume="true" xmlns="urn:xmpp:sm:3" id="11b4ec23-5f6d-4b54-989f-b2f05512e392" max="60" location="9585556aacac"/>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost/2095755800-tigase-21 >> <iq id="FZyboaLKMMWiNXhQ8xu5wp5" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost/2095755800-tigase-21 << <iq xmlns="jabber:client" id="8Vo07gUfIIEGMLT9ACvqXgT" from="localhost" type="result" to="user_x81sqj0029@localhost/2095755800-tigase-21"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost/2095755800-tigase-21 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost/2095755800-tigase-21 << <iq xmlns="jabber:client" id="FZyboaLKMMWiNXhQ8xu5wp5" type="result" to="user_x81sqj0029@localhost/2095755800-tigase-21"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 22:31:20 | Disconnecting

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost/2095755800-tigase-21 << <presence xmlns="jabber:client" from="user_x81sqj0029@localhost/2095755800-tigase-21" to="user_x81sqj0029@localhost"><c node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-05-25 22:31:20 | [Mutex] notify: [disconnected]

2020-05-25 22:31:20 | [Mutex] received everything.

2020-05-25 22:31:20 | [Mutex] waiting for: [event]

2020-05-25 22:31:20 | user :: user_x81sqj0029@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-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3g4MXNxajAwMjkscj1kVUw4NGV4VVQzYXY0YzA2b0dkeQ==</auth>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kVUw4NGV4VVQzYXY0YzA2b0dkeXdYTGVWcWJVOE1CcVR0aVkxaEtSLHM9VnhXdnBYUFZCNStKOXc9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZFVMODRleFVUM2F2NGMwNm9HZHl3WExlVnFiVThNQnFUdGlZMWhLUixwPVc2SmUyaGUzUzNoVFhiRmR5R1FFY3hNWitrRT0=</response>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:20 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:20 | [Mutex] received everything.

2020-05-25 22:31:20 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:20 | [Mutex] waiting for: [event]

2020-05-25 22:31:20 | user :: user_x81sqj0029@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-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfeDgxc3FqMDAyOQAgLSAtIC0gLSAt</auth>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:20 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:20 | [Mutex] received everything.

2020-05-25 22:31:20 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:20 | [Mutex] waiting for: [event]

2020-05-25 22:31:20 | user :: user_x81sqj0029@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-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3g4MXNxajAwMjkscj1DdnNERjVhNlgyWVEzUnAzMU92eQ==</auth>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DdnNERjVhNlgyWVEzUnAzMU92eVg3bncySmdSQnFwc3FoTUNIR3BHLHM9VnhXdnBYUFZCNStKOXc9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q3ZzREY1YTZYMllRM1JwMzFPdnlYN253MkpnUkJxcHNxaE1DSEdwRyxwPTBvMnBSUzNvVGpCamdwdmh4RmYvN2FQZjE0Yz0=</response>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:20 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:20 | [Mutex] received everything.

2020-05-25 22:31:20 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:20 | [Mutex] waiting for: [event]

2020-05-25 22:31:20 | user :: user_x81sqj0029@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-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3g4MXNxajAwMjkscj1jWXIzZE10YWdaMGl1dzl1c1ZidQ==</auth>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jWXIzZE10YWdaMGl1dzl1c1ZidXZiUG9lczI5ekxZWDVXWHRPYlp1LHM9VnhXdnBYUFZCNStKOXc9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y1lyM2RNdGFnWjBpdXc5dXNWYnV2YlBvZXMyOXpMWVg1V1h0T2JadSxwPUoxd0JTYkx5K1UwWVN1cUhNcHNsOTh6YXRTQT0=</response>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:20 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:20 | [Mutex] received everything.

2020-05-25 22:31:20 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:20 | user :: user_x81sqj0029@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-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3g4MXNxajAwMjkscj0wa3V0ZmgyU2I1eklCOWFNeVBlcw==</auth>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wa3V0ZmgyU2I1eklCOWFNeVBlc3lxZ1N6VWpJVlg1RUMyUTVMaGd4LHM9eXJsR2xSOFd0QWN6a3c9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MGt1dGZoMlNiNXpJQjlhTXlQZXN5cWdTelVqSVZYNUVDMlE1TGhneCxwPTlTUUM0ZXZ0Y29CNVBhaU9yeU9DT1NrT29KTzZlcWpGZTJmRDB0L3dqbDQ9</response>

2020-05-25 22:31:20 | user :: user_x81sqj0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2020-05-25 22:31:22 | [Mutex] waiting for: [user]

2020-05-25 22:31:22 | [Mutex] received everything.

2020-05-25 22:31:22 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.127s
2020-05-25 22:31:22 |

2020-05-25 22:31:22 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-05-25 22:31:22 | ------------------------------------

2020-05-25 22:31:22 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@32f5ea72

2020-05-25 22:31:22 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@960adae}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c32025c}, 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@380d8102}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d0f0867}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@60b4dbce}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:22 PDT 2020}}}}

2020-05-25 22:31:22 | [Mutex] waiting for: [registration]

2020-05-25 22:31:22 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4c381566

2020-05-25 22:31:22 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c32025c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@380d8102}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d0f0867}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@60b4dbce}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:22 PDT 2020}}}}

2020-05-25 22:31:22 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@18699872

2020-05-25 22:31:22 | 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-05-25 22:31:22 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d20f728}

2020-05-25 22:31:22 | 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-05-25 22:31:22 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-05-25 22:31:22 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2020-05-25 22:31:22 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5b8c25e9

2020-05-25 22:31:22 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@571398db

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

2020-05-25 22:31:22 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@36d3043}

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

2020-05-25 22:31:22 | user :: null >> <iq to="localhost" id="qTaEFBAFFCeJDhMyjSRKSbA" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-05-25 22:31:22 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3d15d012}

2020-05-25 22:31:22 | user :: null << <iq xmlns="jabber:client" id="qTaEFBAFFCeJDhMyjSRKSbA" from="localhost" type="result"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (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" label="Username" type="text-single"><required/><value/></field><field var="password" label="Password" type="text-private"><required/><value/></field><field var="email" label="Email (MUST BE VALID!)" type="text-single"><required/><value/></field></x></query></iq>

2020-05-25 22:31:22 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@196e0eb1}

2020-05-25 22:31:22 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@23f7c318

2020-05-25 22:31:22 | user :: null >> <iq to="localhost" id="TfcDGtiXbKZjUOTXV48tcv2" type="set"><query xmlns="jabber:iq:register"><username>user_tphkd10030</username><password>user_tphkd10030</password><email>31eca699-c2fa-4cc6-b06d-c1b96b2c1da1@localhost</email></query></iq>

2020-05-25 22:31:22 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@342d94bf}

2020-05-25 22:31:23 | user :: null << <iq xmlns="jabber:client" id="TfcDGtiXbKZjUOTXV48tcv2" from="localhost" type="result"/>

2020-05-25 22:31:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@68e952fd}

2020-05-25 22:31:23 | [Mutex] received everything.

2020-05-25 22:31:23 | [Mutex] isItemNotified: registrationSuccess :: true

2020-05-25 22:31:23 | 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;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d20f728, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@36d3043]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c32025c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@380d8102}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d0f0867}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@60b4dbce}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:23 PDT 2020}}}}

2020-05-25 22:31:23 | 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;@960adae}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d20f728, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@36d3043]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c32025c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@485da795}, 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@380d8102}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d0f0867}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@60b4dbce}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon May 25 22:31:23 PDT 2020}}}}

2020-05-25 22:31:23 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2ec888b

2020-05-25 22:31:23 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6b9e15e1

2020-05-25 22:31:23 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@76ecf489

2020-05-25 22:31:23 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@54302e13

2020-05-25 22:31:23 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@32fe5cce

2020-05-25 22:31:23 | user :: user_tphkd10030@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-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RwaGtkMTAwMzAscj1vUEtjYkJGWWhrUTJYdzBRR3Jmdg==</auth>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vUEtjYkJGWWhrUTJYdzBRR3Jmdkt2QVRFbXFoeFp2TTZtN0JpTXhhLHM9TUpZY2FyY0JkU1hoZnc9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b1BLY2JCRlloa1EyWHcwUUdyZnZLdkFURW1xaHhadk02bTdCaU14YSxwPUdhc0g4ekFXR0huTzdZYVdoNkZUZlJXN2ZUeVVwMXlGSHViWUZrV1BELzA9</response>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0zbUdMemZMTEIxRHIxWkZMNGh2Q0FwNS9ta0IvRnk3Tnc1T2EwTVovbnF3PQ==</success>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1" ver="z4E8/RbDarYCAPa9avxwCC7J86E="/></features>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <iq xmlns="jabber:client" id="Ic1r6ucMY9FHGOTcvm5rg1n" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <iq xmlns="jabber:client" id="Ic1r6ucMY9FHGOTcvm5rg1n" type="result" to="user_tphkd10030@localhost/2095755800-tigase-22"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_tphkd10030@localhost/2095755800-tigase-22</jid></bind></iq>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-22 >> <iq xmlns="jabber:client" id="Of8rfR0sbMFGJJQbHGmZ9jQ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-22 << <iq xmlns="jabber:client" id="Of8rfR0sbMFGJJQbHGmZ9jQ" type="result" to="user_tphkd10030@localhost/2095755800-tigase-22"/>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-22 >> <iq to="localhost" id="Ne3ubJPWkVgDCBtk9Dy6t7f" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-22 >> <iq id="bT0m9wkS8Gzvn2wj2bINR6H" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-22 << <enabled resume="true" xmlns="urn:xmpp:sm:3" id="13e8700e-87d6-400e-b556-089277d379fd" max="60" location="9585556aacac"/>

2020-05-25 22:31:23 | Disconnecting

2020-05-25 22:31:23 | [Mutex] notify: [disconnected]

2020-05-25 22:31:23 | [Mutex] received everything.

2020-05-25 22:31:23 | [Mutex] waiting for: [event]

2020-05-25 22:31:23 | user :: user_tphkd10030@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-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RwaGtkMTAwMzAscj1WZ2NOWHJ2eUdTNkRDZFNReGxMMQ==</auth>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WZ2NOWHJ2eUdTNkRDZFNReGxMMXI4eEdpSVRkdEZJSnBCRHAwQlJ4LHM9TUpZY2FyY0JkU1hoZnc9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VmdjTlhydnlHUzZEQ2RTUXhsTDFyOHhHaUlUZHRGSUpwQkRwMEJSeCxwPXdoSW9MZDFKUmpFWDlKU3VUbldCY3o2RzQwWVpETXQ2bEpwVjBrRjY0VGc9</response>

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

2020-05-25 22:31:23 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:23 | [Mutex] received everything.

2020-05-25 22:31:23 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:23 | [Mutex] waiting for: [event]

2020-05-25 22:31:23 | user :: user_tphkd10030@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-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RwaGtkMTAwMzAscj1aT2E1Y3RHdlA0bVk5SDNOWDdxMA==</auth>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aT2E1Y3RHdlA0bVk5SDNOWDdxMDZKZ3BTVzdDQ3RvdXhXaVQ2WkZoLHM9TUpZY2FyY0JkU1hoZnc9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Wk9hNWN0R3ZQNG1ZOUgzTlg3cTA2SmdwU1c3Q0N0b3V4V2lUNlpGaCxwPTM0blJWUGJJd0w5b3lneUhxZy9nM1dJc1lqWFVBMkhVQWo3bXFtNlBndVk9</response>

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

2020-05-25 22:31:23 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:23 | [Mutex] received everything.

2020-05-25 22:31:23 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:23 | [Mutex] waiting for: [event]

2020-05-25 22:31:23 | user :: user_tphkd10030@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-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RwaGtkMTAwMzAscj1Oc0ZOdEJlN2FoWlRaaFMzdFQ2Zg==</auth>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Oc0ZOdEJlN2FoWlRaaFMzdFQ2ZmR3Ym1CWkhUNnUyUW5xNTYyMjFuLHM9TUpZY2FyY0JkU1hoZnc9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TnNGTnRCZTdhaFpUWmhTM3RUNmZkd2JtQlpIVDZ1MlFucTU2MjIxbixwPUtaVUV4ZGFURDJ0WnVSbGJZczUvZFpKM2d2eFdyTjRkRjhvbHg5M0Y5RTQ9</response>

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

2020-05-25 22:31:23 | [Mutex] notify: [event, authFailed]

2020-05-25 22:31:23 | [Mutex] received everything.

2020-05-25 22:31:23 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 22:31:23 | user :: user_tphkd10030@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-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3RwaGtkMTAwMzAscj14Q0l2dnAwQnVLOEJWbTY2YVVUYg==</auth>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14Q0l2dnAwQnVLOEJWbTY2YVVUYmpIZUNJUDZBMmVvRjdleVA4OHZhLHM9TUpZY2FyY0JkU1hoZnc9PSxpPTQwOTY=</challenge>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eENJdnZwMEJ1SzhCVm02NmFVVGJqSGVDSVA2QTJlb0Y3ZXlQODh2YSxwPTJ0U3M1VklLeHM3TFpmSGlRL1VDcTJPdmtrVS9nVjhHVlRLczd2MHZIdVE9</response>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1sT2cxa1N3R21NNVM5VlFSSklod0x2MXFocFNFakJXUGVXL0Z5S1JPRlF3PQ==</success>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1" ver="z4E8/RbDarYCAPa9avxwCC7J86E="/></features>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost >> <iq xmlns="jabber:client" id="TkhN07Axl4DBuYdBdEiNQNC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost << <iq xmlns="jabber:client" id="TkhN07Axl4DBuYdBdEiNQNC" type="result" to="user_tphkd10030@localhost/2095755800-tigase-23"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_tphkd10030@localhost/2095755800-tigase-23</jid></bind></iq>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-23 >> <iq xmlns="jabber:client" id="LbOO0q3tjUgN07Axl4DBuYd" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-23 << <iq xmlns="jabber:client" id="LbOO0q3tjUgN07Axl4DBuYd" type="result" to="user_tphkd10030@localhost/2095755800-tigase-23"/>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-23 >> <iq to="localhost" id="a1iAyxiSYk4l3teU5AhUbDE" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-23 << <enabled resume="true" xmlns="urn:xmpp:sm:3" id="89cc28a0-26b4-4338-a1d2-e011991fae7e" max="60" location="9585556aacac"/>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-23 >> <iq id="xdQEzjDuY9ydsi1gOQ4yjZl" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-23 << <iq xmlns="jabber:client" id="a1iAyxiSYk4l3teU5AhUbDE" from="localhost" type="result" to="user_tphkd10030@localhost/2095755800-tigase-23"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2020-05-25 22:31:23 | user :: user_tphkd10030@localhost/2095755800-tigase-23 << <iq xmlns="jabber:client" id="xdQEzjDuY9ydsi1gOQ4yjZl" type="result" to="user_tphkd10030@localhost/2095755800-tigase-23"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 22:31:23 | Disconnecting

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

2020-05-25 22:31:23 | [Mutex] notify: [disconnected]

2020-05-25 22:31:23 | [Mutex] received everything.

2020-05-25 22:31:25 | [Mutex] waiting for: [user]

2020-05-25 22:31:25 | [Mutex] received everything.

2020-05-25 22:31:25 | [Mutex] isItemNotified: user:ok:true :: true