Brute Force Prevention

Test duration: 15.783s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.792s
2020-05-25 23:47:48 |

2020-05-25 23:47:48 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-05-25 23:47:48 | ------------------------------------

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@a0c8a94

2020-05-25 23:47:48 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@f286bbd}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4cb65a5}, 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@f4e1e4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@45f66f9e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b40159e}, 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 23:47:48 PDT 2020}}}}

2020-05-25 23:47:48 | [Mutex] waiting for: [registration]

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@74f9ab1e

2020-05-25 23:47:48 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4cb65a5}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@f4e1e4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@45f66f9e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b40159e}, 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 23:47:48 PDT 2020}}}}

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@53a58fa4

2020-05-25 23:47:48 | 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 23:47:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@25d990d1}

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

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

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@e9e8d11

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@37067687

2020-05-25 23:47:48 | 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 23:47:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@48a1076c}

2020-05-25 23:47:48 | 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 23:47:48 | user :: null >> <iq to="localhost" id="SzYV7IBiJx5xds8u1bqXVYq" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-05-25 23:47:48 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@9bca7e2c}

2020-05-25 23:47:48 | user :: null << <iq id="SzYV7IBiJx5xds8u1bqXVYq" xmlns="jabber:client" type="result" from="localhost"><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 label="Username" var="username" type="text-single"><required/><value/></field><field label="Password" var="password" type="text-private"><required/><value/></field><field label="Email (MUST BE VALID!)" var="email" type="text-single"><required/><value/></field></x></query></iq>

2020-05-25 23:47:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@219749b1}

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5b9bbe97

2020-05-25 23:47:48 | user :: null >> <iq to="localhost" id="aTUalLHvvo5jIyhzpiLCnPF" type="set"><query xmlns="jabber:iq:register"><username>user_r1niy00027</username><password>user_r1niy00027</password><email>0982f6ba-b2e4-4b43-b1f8-6276024eef6a@localhost</email></query></iq>

2020-05-25 23:47:48 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b11d4f66}

2020-05-25 23:47:48 | user :: null << <iq id="aTUalLHvvo5jIyhzpiLCnPF" xmlns="jabber:client" type="result" from="localhost"/>

2020-05-25 23:47:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5f2d592d}

2020-05-25 23:47:48 | [Mutex] received everything.

2020-05-25 23:47:48 | [Mutex] isItemNotified: registrationSuccess :: true

2020-05-25 23:47:48 | 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;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@25d990d1, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@48a1076c]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4cb65a5}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@f4e1e4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@45f66f9e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b40159e}, 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 23:47:48 PDT 2020}}}}

2020-05-25 23:47:48 | 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;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@25d990d1, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@48a1076c]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4cb65a5}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@f4e1e4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@45f66f9e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b40159e}, 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 23:47:48 PDT 2020}}}}

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1ff7bfc3

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@4b6b74d

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2dfde4a

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@378e0b0d

2020-05-25 23:47:48 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@15a5b398

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

2020-05-25 23:47:48 | user :: user_r1niy00027@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 23:47:48 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1CeG4yMEN0eDUwdWRaRFpCR3ZVbw==</auth>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CeG4yMEN0eDUwdWRaRFpCR3ZVb3g4VXliR3AwSkJHNFdYbWpRYWpLLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QnhuMjBDdHg1MHVkWkRaQkd2VW94OFV5YkdwMEpCRzRXWG1qUWFqSyxwPVpDTTdOV1RKdXJmN29YNWFVV3grcW9tSXhlMzhmVWxyUDJwcTdPTTB5WjA9</response>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0ybnExblE2OWo0aitOSjJiYmw2S1VTbDdHSVU2UHBhTmprc2tPeXlPOC93PQ==</success>

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

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost >> <iq xmlns="jabber:client" id="nrwh2fAjHpbv2iOFt07fCIO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost << <iq to="user_r1niy00027@localhost/2095755800-tigase-19" id="nrwh2fAjHpbv2iOFt07fCIO" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_r1niy00027@localhost/2095755800-tigase-19</jid></bind></iq>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost/2095755800-tigase-19 >> <iq xmlns="jabber:client" id="3FalPIx5i4w3bxbR6v9oUZZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost/2095755800-tigase-19 << <iq to="user_r1niy00027@localhost/2095755800-tigase-19" id="3FalPIx5i4w3bxbR6v9oUZZ" xmlns="jabber:client" type="result"/>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost/2095755800-tigase-19 >> <iq to="localhost" id="6wHtX2yuZ3hFP2nTSSVRZs5" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost/2095755800-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost/2095755800-tigase-19 << <enabled resume="true" id="0698131e-bcb5-4ce0-a5e2-fd4a62a1900b" xmlns="urn:xmpp:sm:3" max="60" location="9585556aacac"/>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost/2095755800-tigase-19 >> <iq id="OMrZ4gHp5Et2dv1pXW6qTVU" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 23:47:48 | user :: user_r1niy00027@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 23:47:48 | user :: user_r1niy00027@localhost/2095755800-tigase-19 << <iq to="user_r1niy00027@localhost/2095755800-tigase-19" id="6wHtX2yuZ3hFP2nTSSVRZs5" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost/2095755800-tigase-19 << <iq to="user_r1niy00027@localhost/2095755800-tigase-19" id="OMrZ4gHp5Et2dv1pXW6qTVU" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 23:47:48 | Disconnecting

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

2020-05-25 23:47:48 | [Mutex] notify: [disconnected]

2020-05-25 23:47:48 | [Mutex] received everything.

2020-05-25 23:47:48 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:48 | user :: user_r1niy00027@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 23:47:48 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj10alJCcVlEQ0d1QnNTNXV4SzJraw==</auth>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10alJCcVlEQ0d1QnNTNXV4SzJra3JIUmtSbjQxTHpqeERqZndrUnkxLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dGpSQnFZRENHdUJzUzV1eEsya2tySFJrUm40MUx6anhEamZ3a1J5MSxwPU5STTFzbFQ5MmRjWXRYVWpqNHhJRHFEN0NlYTlmZVpVOS84ZmFPUGN5aUE9</response>

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

2020-05-25 23:47:48 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:48 | [Mutex] received everything.

2020-05-25 23:47:48 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:48 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:48 | user :: user_r1niy00027@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 23:47:48 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj0yTGNEVDVoRkJQNXlDM2RaRlZOcQ==</auth>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yTGNEVDVoRkJQNXlDM2RaRlZOcW1zMHdtdnF6cFVHbkNKdkxVdFBHLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MkxjRFQ1aEZCUDV5QzNkWkZWTnFtczB3bXZxenBVR25DSnZMVXRQRyxwPU5ZcytJNTVPbXFGN3pma1Z1bStRSk1kTkkzZ01jMDFlVWZSWWJjUHpTeVU9</response>

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

2020-05-25 23:47:48 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:48 | [Mutex] received everything.

2020-05-25 23:47:48 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:48 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:48 | user :: user_r1niy00027@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 23:47:48 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1tZEFuWE4xcEdXSTloWVJpUXlicA==</auth>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tZEFuWE4xcEdXSTloWVJpUXlicHhJR2gyNVhvRnZnNjFCYXRtS1BKLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:48 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bWRBblhOMXBHV0k5aFlSaVF5YnB4SUdoMjVYb0Z2ZzYxQmF0bUtQSixwPTA3aXRaUURoSk56aisvVGtmUmM3bEFva3hMVm81Nk5QekxZK1FzZ1J6R2M9</response>

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

2020-05-25 23:47:48 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:48 | [Mutex] received everything.

2020-05-25 23:47:48 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:48 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:49 | user :: user_r1niy00027@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 23:47:49 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj11YVBZOFNES0VvNzU4SVRQOFBhNQ==</auth>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11YVBZOFNES0VvNzU4SVRQOFBhNVBOdlNobHhrRUVNek1Rb0RVQ0kxLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWFQWThTREtFbzc1OElUUDhQYTVQTnZTaGx4a0VFTXpNUW9EVUNJMSxwPXJCMUt0VzlQcFlPRlZHdUpHMU1XT29hUklUUXFmU3pQNzFuV1JQL24yUWc9</response>

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

2020-05-25 23:47:49 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:49 | [Mutex] received everything.

2020-05-25 23:47:49 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:49 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:49 | user :: user_r1niy00027@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 23:47:49 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj15U1ltamVrREwwUnhyUUxiRlNlSw==</auth>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15U1ltamVrREwwUnhyUUxiRlNlS0N5RDVoRFFBM0tYMmFPMUhjcEtOLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eVNZbWpla0RMMFJ4clFMYkZTZUtDeUQ1aERRQTNLWDJhTzFIY3BLTixwPTI5dEtkR0xjYzBEemlXc1dUY3pFR2tpK2tTdWhtMmdvVHQyZE5BbG13Q2M9</response>

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

2020-05-25 23:47:49 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:49 | [Mutex] received everything.

2020-05-25 23:47:49 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:49 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:49 | user :: user_r1niy00027@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 23:47:49 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj00dW5tbWN0QXVvUGh0ZzlTSEluSA==</auth>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00dW5tbWN0QXVvUGh0ZzlTSEluSDNsUlB5MmFmSHZrODcwdlEybFJjLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NHVubW1jdEF1b1BodGc5U0hJbkgzbFJQeTJhZkh2azg3MHZRMmxSYyxwPUIwQkR2Skt3bk9PNHRPcldianpzZHdRUlhLK0s0eVZjckhOYktuQlpVS1U9</response>

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

2020-05-25 23:47:49 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:49 | [Mutex] received everything.

2020-05-25 23:47:49 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:49 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:49 | user :: user_r1niy00027@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 23:47:49 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1KQnR2Z1dyTDZodUZHVjREM3A2WA==</auth>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KQnR2Z1dyTDZodUZHVjREM3A2WEpic3UzOW9uSVlYRFlPTkNybXQ0LHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SkJ0dmdXckw2aHVGR1Y0RDNwNlhKYnN1MzlvbklZWERZT05Dcm10NCxwPWYyS2ZPR0VVU0NVQ3ZzNnBta0lIZU4vbWhlS0JwRmhzdTZjSmlaWTZWM3c9</response>

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

2020-05-25 23:47:49 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:49 | [Mutex] received everything.

2020-05-25 23:47:49 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:49 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:49 | user :: user_r1niy00027@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 23:47:49 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj03Wk1uM0pmYWU1U0lhYTNleDNnNQ==</auth>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03Wk1uM0pmYWU1U0lhYTNleDNnNWpKa0Mza1pTMTJOOXNNNHJiY0s0LHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N1pNbjNKZmFlNVNJYWEzZXgzZzVqSmtDM2taUzEyTjlzTTRyYmNLNCxwPVZJYXpibWRnNGhGeVhXZnVvZUlaalM4VXRIK28za0VyQnpnYnFiekFXd3c9</response>

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

2020-05-25 23:47:49 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:49 | [Mutex] received everything.

2020-05-25 23:47:49 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:49 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:49 | user :: user_r1niy00027@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 23:47:49 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj0xdklJemxvRWlRT2hKbVVyaVpXZw==</auth>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xdklJemxvRWlRT2hKbVVyaVpXZ0JVSlZVbDJUREZvMGdUR1Q0TEdSLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:49 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MXZJSXpsb0VpUU9oSm1VcmlaV2dCVUpWVWwyVERGbzBnVEdUNExHUixwPUhGVVRPcVpGWXFtdTVBemFrakswV1hCNzh2eGhnR0QwY3p0TTRzQXBOeG89</response>

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

2020-05-25 23:47:49 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:49 | [Mutex] received everything.

2020-05-25 23:47:49 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:49 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:49 | user :: user_r1niy00027@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 23:47:49 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1JamRMZzAzbTBjTFAxOUZLb2NvUQ==</auth>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JamRMZzAzbTBjTFAxOUZLb2NvUVFnT2Z2SWVJZU15dnBlbERFSnRCLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SWpkTGcwM20wY0xQMTlGS29jb1FRZ09mdkllSWVNeXZwZWxERUp0QixwPW4zUElEQWFTVkR4MWgrUXlZWHFocGlGNWdrWkNpTCtsL3AzYTFsM1JBWW89</response>

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

2020-05-25 23:47:50 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:50 | [Mutex] received everything.

2020-05-25 23:47:50 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:50 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:50 | user :: user_r1niy00027@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 23:47:50 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1IZTdORFVUSmNGQThMaGR2QklkVA==</auth>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IZTdORFVUSmNGQThMaGR2QklkVFFUQ0h4UmJwN0FldzdtdDZFUmpsLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SGU3TkRVVEpjRkE4TGhkdkJJZFRRVENIeFJicDdBZXc3bXQ2RVJqbCxwPW1LekQ1NEZZd2xVWHB2bGt0VE8wWVE2cHRxYnMwelF4QkpZN0ZLNjNuakU9</response>

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

2020-05-25 23:47:50 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:50 | [Mutex] received everything.

2020-05-25 23:47:50 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:50 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:50 | user :: user_r1niy00027@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 23:47:50 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj16Tk5YaXlSYjZYV3pVQ0JwbGE1dg==</auth>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16Tk5YaXlSYjZYV3pVQ0JwbGE1dnZDYUhxcmxSVkttTFdzOU5ETDJTLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ek5OWGl5UmI2WFd6VUNCcGxhNXZ2Q2FIcXJsUlZLbUxXczlOREwyUyxwPVpZOGhQRjM0ZVFobmo3QjlvWXFIS1Bjak0rODNZK09uTEJIbTErMWt2LzQ9</response>

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

2020-05-25 23:47:50 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:50 | [Mutex] received everything.

2020-05-25 23:47:50 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:50 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:50 | user :: user_r1niy00027@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 23:47:50 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1HNjQ4M3BiZzJpN2JoNU9wdmYyRw==</auth>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HNjQ4M3BiZzJpN2JoNU9wdmYyRzA3WDRFUHBqaGVrNUNFME5naDJDLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RzY0ODNwYmcyaTdiaDVPcHZmMkcwN1g0RVBwamhlazVDRTBOZ2gyQyxwPWxMQnhnb3UxRzdYN0tIYXlWcHVHK05kc0RJUFloTmpwR2d6T3FCSFdzZHc9</response>

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

2020-05-25 23:47:50 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:50 | [Mutex] received everything.

2020-05-25 23:47:50 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:50 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:50 | user :: user_r1niy00027@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 23:47:50 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1rcHlqSk44S3ZhY3JJcmpTRm43OA==</auth>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rcHlqSk44S3ZhY3JJcmpTRm43OFVPN0syaHFEQUxRSDI5THVIUUhyLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a3B5akpOOEt2YWNySXJqU0ZuNzhVTzdLMmhxREFMUUgyOUx1SFFIcixwPWtiT0J2OUVkS2tlUUorL1R6U21oVzhWeHJuMWZtOU1YTHQ4Nnd1WEVid1k9</response>

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

2020-05-25 23:47:50 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:50 | [Mutex] received everything.

2020-05-25 23:47:50 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:50 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:50 | user :: user_r1niy00027@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 23:47:50 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1NTXRYRXBnM2NqaTBTV3ZiM1dqQg==</auth>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NTXRYRXBnM2NqaTBTV3ZiM1dqQnI3VlNzbmluMTNKdDZ3QnQxalp5LHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TU10WEVwZzNjamkwU1d2YjNXakJyN1ZTc25pbjEzSnQ2d0J0MWpaeSxwPWpHRzVIbTlQQkNxZHQ3Mml4cXRKbTNxTWFsN05NMFhvb2kwRWhkY2VzL0U9</response>

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

2020-05-25 23:47:50 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:50 | [Mutex] received everything.

2020-05-25 23:47:50 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:50 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:50 | user :: user_r1niy00027@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 23:47:50 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1MRFFNdERJQk9zM3pkMjFweDkxTw==</auth>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MRFFNdERJQk9zM3pkMjFweDkxT1J0ZXJhbGNyaGxwb2Y5MERQOXptLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:50 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TERRTXRESUJPczN6ZDIxcHg5MU9SdGVyYWxjcmhscG9mOTBEUDl6bSxwPURiV1QxZCswYnZ2dDBBVTZhSWMrc1FoV2Q2T1FwK2xRakhGaFlvczRVR2s9</response>

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

2020-05-25 23:47:50 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:50 | [Mutex] received everything.

2020-05-25 23:47:50 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:50 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:51 | user :: user_r1niy00027@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 23:47:51 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj05dzhySld0S2thSkl6YVY3QllxRA==</auth>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05dzhySld0S2thSkl6YVY3QllxRGxIRXJaNm1XOUNPeDVHYXdIWkRDLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OXc4ckpXdEtrYUpJemFWN0JZcURsSEVyWjZtVzlDT3g1R2F3SFpEQyxwPUNEcFBQT2RBSk9haXpRSzVEckJPT29IR3BVRDBqcmx1MW5MS3J1M042SkE9</response>

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

2020-05-25 23:47:51 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:51 | [Mutex] received everything.

2020-05-25 23:47:51 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:51 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:51 | user :: user_r1niy00027@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 23:47:51 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj0ySUt2OTJaZ3Z5WjVPSjRIa1BOUQ==</auth>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0ySUt2OTJaZ3Z5WjVPSjRIa1BOUURyOEpDaW9ZWWRjVHZKbzhkYTNCLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MklLdjkyWmd2eVo1T0o0SGtQTlFEcjhKQ2lvWVlkY1R2Sm84ZGEzQixwPWY2NTljU2c1L0VRbkJOK1NDTnFCK0xSY3RSYmdrVHBqRUZKRTBYb0MwNlk9</response>

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

2020-05-25 23:47:51 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:51 | [Mutex] received everything.

2020-05-25 23:47:51 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:51 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:51 | user :: user_r1niy00027@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 23:47:51 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1UbTQzZTBvb3R5RHBsbDMwY3ZKWQ==</auth>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UbTQzZTBvb3R5RHBsbDMwY3ZKWTlubEh2OEx3Y3VYaFZZWkFLQ3ZzLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VG00M2Uwb290eURwbGwzMGN2Slk5bmxIdjhMd2N1WGhWWVpBS0N2cyxwPWJvbnErRkh3YXE0eDFPSUhaYVVUZEdKY3BzeWhVamN5em02VXVVSWtsdjQ9</response>

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

2020-05-25 23:47:51 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:51 | [Mutex] received everything.

2020-05-25 23:47:51 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:51 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:51 | user :: user_r1niy00027@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 23:47:51 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1FZVdQMnJ4NVUxNTVGcm1NUmxHSw==</auth>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FZVdQMnJ4NVUxNTVGcm1NUmxHS0t6VGxwTTNkNHkwSTk1OVZXYVo3LHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RWVXUDJyeDVVMTU1RnJtTVJsR0tLelRscE0zZDR5MEk5NTlWV2FaNyxwPW53TGdDSkhWTTBTbTJWYmxzZ0lUZE4rZnl4blN1UFRTNFdyWFJXTkVDWjg9</response>

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

2020-05-25 23:47:51 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:51 | [Mutex] received everything.

2020-05-25 23:47:51 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:51 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:51 | user :: user_r1niy00027@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 23:47:51 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1BamhFSTNsZzkxckdGRjc4anJVNg==</auth>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BamhFSTNsZzkxckdGRjc4anJVNllpWTc5Y0xleXhpT1M0WmpWcmtkLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QWpoRUkzbGc5MXJHRkY3OGpyVTZZaVk3OWNMZXl4aU9TNFpqVnJrZCxwPURDR29Sck1vbjBlb1JOWG5uT0F5a2dlRDNIT05nbnd2TmtBOXo5QXZ4M1E9</response>

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

2020-05-25 23:47:51 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:51 | [Mutex] received everything.

2020-05-25 23:47:51 | [Mutex] isItemNotified: authFailed :: true

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

2020-05-25 23:47:51 | user :: user_r1niy00027@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 23:47:51 | user :: user_r1niy00027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Ixbml5MDAwMjcscj1KNU00Y0xkY044eTdwa0ZLeHRxWA==</auth>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KNU00Y0xkY044eTdwa0ZLeHRxWEFNbkJ6WjFOZ2h4Mm9mSjhuVUNLLHM9QmlzRzBFUGlIWFlpanc9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:51 | user :: user_r1niy00027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SjVNNGNMZGNOOHk3cGtGS3h0cVhBTW5CeloxTmdoeDJvZko4blVDSyxwPXZadEJVMjBtb1RjOHk5YVB2V1I2RXR5bmllSlhuek5WaDB6Uk9KUXBxNjg9</response>

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

2020-05-25 23:47:53 | [Mutex] waiting for: [user]

2020-05-25 23:47:53 | [Mutex] received everything.

2020-05-25 23:47:53 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.219s
2020-05-25 23:47:53 |

2020-05-25 23:47:53 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-05-25 23:47:53 | ------------------------------------

2020-05-25 23:47:53 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@30d81e0a

2020-05-25 23:47:53 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@f286bbd}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3e1fe661}, 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@3a20757a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7f22ec5a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@ffa95fa}, 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 23:47:53 PDT 2020}}}}

2020-05-25 23:47:53 | [Mutex] waiting for: [registration]

2020-05-25 23:47:53 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4e97568a

2020-05-25 23:47:53 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3e1fe661}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@3a20757a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7f22ec5a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@ffa95fa}, 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 23:47:53 PDT 2020}}}}

2020-05-25 23:47:53 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@77a57187

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

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

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

2020-05-25 23:47:53 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@4483004b

2020-05-25 23:47:53 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@30543d57

2020-05-25 23:47:54 | 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 23:47:54 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6ca15b93}

2020-05-25 23:47:54 | 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 23:47:54 | user :: null >> <iq to="localhost" id="BF02bnSeQHt7lbKNJyeDhP8" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-05-25 23:47:54 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6c61e09d}

2020-05-25 23:47:54 | user :: null << <iq id="BF02bnSeQHt7lbKNJyeDhP8" xmlns="jabber:client" type="result" from="localhost"><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 label="Username" var="username" type="text-single"><required/><value/></field><field label="Password" var="password" type="text-private"><required/><value/></field><field label="Email (MUST BE VALID!)" var="email" type="text-single"><required/><value/></field></x></query></iq>

2020-05-25 23:47:54 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1b4368a9}

2020-05-25 23:47:54 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@471ea2d2

2020-05-25 23:47:54 | user :: null >> <iq to="localhost" id="HVKt1dxzwlPKCpPVkPKDlHL" type="set"><query xmlns="jabber:iq:register"><username>user_hdo8sp0028</username><password>user_hdo8sp0028</password><email>5afb9f78-2967-4d03-883b-16704e8a60e1@localhost</email></query></iq>

2020-05-25 23:47:54 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@9bebe1f}

2020-05-25 23:47:54 | user :: null << <iq id="HVKt1dxzwlPKCpPVkPKDlHL" xmlns="jabber:client" type="result" from="localhost"/>

2020-05-25 23:47:54 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@563191e3}

2020-05-25 23:47:54 | [Mutex] received everything.

2020-05-25 23:47:54 | [Mutex] isItemNotified: registrationSuccess :: true

2020-05-25 23:47:54 | 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;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f0d1315, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6ca15b93]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3e1fe661}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@3a20757a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7f22ec5a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@ffa95fa}, 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 23:47:54 PDT 2020}}}}

2020-05-25 23:47:54 | 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;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f0d1315, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6ca15b93]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3e1fe661}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@3a20757a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7f22ec5a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@ffa95fa}, 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 23:47:54 PDT 2020}}}}

2020-05-25 23:47:54 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@30aa3575

2020-05-25 23:47:54 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@302c15e9

2020-05-25 23:47:54 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@296390c

2020-05-25 23:47:54 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@58720e34

2020-05-25 23:47:54 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@391299d2

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

2020-05-25 23:47:54 | user :: user_hdo8sp0028@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 23:47:54 | user :: user_hdo8sp0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hkbzhzcDAwMjgscj04TlpFcHBGbDMyR3lIZlNSeFhHSQ==</auth>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04TlpFcHBGbDMyR3lIZlNSeFhHSWNvdzkwZm5FUWRlQWhLVmxFb1pmLHM9OTk2QThmb3NDcDhWVUE9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OE5aRXBwRmwzMkd5SGZTUnhYR0ljb3c5MGZuRVFkZUFoS1ZsRW9aZixwPUZiR2VLZ0dsK0pSeVVuK0d1VEkxSnJ1MzFIMzJqU3VWYUVYVFd3VHI4S0E9</response>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1mRmFpQXNlMUh2TnNVd3B0MWNQOFBVUHlsL3FlaklwZndoWUtBc0V3ekNRPQ==</success>

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

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost >> <iq xmlns="jabber:client" id="G23sVV19NYfDmQRJJW3cx9j" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost << <iq to="user_hdo8sp0028@localhost/2095755800-tigase-20" id="G23sVV19NYfDmQRJJW3cx9j" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_hdo8sp0028@localhost/2095755800-tigase-20</jid></bind></iq>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost/2095755800-tigase-20 >> <iq xmlns="jabber:client" id="4CLDkLxcS8hDrZtkX3cwdr9" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost/2095755800-tigase-20 << <iq to="user_hdo8sp0028@localhost/2095755800-tigase-20" id="4CLDkLxcS8hDrZtkX3cwdr9" xmlns="jabber:client" type="result"/>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost/2095755800-tigase-20 >> <iq to="localhost" id="mLajTgHu7jDDpQU27nOJt4C" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost/2095755800-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost/2095755800-tigase-20 << <enabled resume="true" id="8d072e5c-4217-465f-9f02-e2b66fb988c6" xmlns="urn:xmpp:sm:3" max="60" location="9585556aacac"/>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost/2095755800-tigase-20 >> <iq id="hZOTVW0bn1wdwbrT9rU2iDp" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@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 23:47:54 | user :: user_hdo8sp0028@localhost/2095755800-tigase-20 << <iq to="user_hdo8sp0028@localhost/2095755800-tigase-20" id="mLajTgHu7jDDpQU27nOJt4C" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost/2095755800-tigase-20 << <iq to="user_hdo8sp0028@localhost/2095755800-tigase-20" id="hZOTVW0bn1wdwbrT9rU2iDp" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 23:47:54 | Disconnecting

2020-05-25 23:47:54 | [Mutex] notify: [disconnected]

2020-05-25 23:47:54 | [Mutex] received everything.

2020-05-25 23:47:54 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:54 | user :: user_hdo8sp0028@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 23:47:54 | user :: user_hdo8sp0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hkbzhzcDAwMjgscj1lM1UycHVPUXBUWGVjYlRUeGRSRw==</auth>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lM1UycHVPUXBUWGVjYlRUeGRSR3VobjVrSGhtUEQwZFhlUnJwY29DLHM9OTk2QThmb3NDcDhWVUE9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZTNVMnB1T1FwVFhlY2JUVHhkUkd1aG41a0hobVBEMGRYZVJycGNvQyxwPWJvOVJjM3pHZEpwVXEwNVBiVFU1VUhVZmhrV0prN3pnendpeVNEVHQ1aWs9</response>

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

2020-05-25 23:47:54 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:54 | [Mutex] received everything.

2020-05-25 23:47:54 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:54 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:54 | user :: user_hdo8sp0028@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 23:47:54 | user :: user_hdo8sp0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hkbzhzcDAwMjgscj1OcXZJSVZxcUtoVzhrRjRqNUV1SQ==</auth>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OcXZJSVZxcUtoVzhrRjRqNUV1SWR2cjV1ZnVsdWZkM1BxMEVwSWlZLHM9OTk2QThmb3NDcDhWVUE9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TnF2SUlWcXFLaFc4a0Y0ajVFdUlkdnI1dWZ1bHVmZDNQcTBFcElpWSxwPVpxQ0Z5c3BLNWkzVHVMN0FXSHczWDM3cEkrUnpmUVR1aTNEcTVxanFVTDQ9</response>

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

2020-05-25 23:47:54 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:54 | [Mutex] received everything.

2020-05-25 23:47:54 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:54 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:54 | user :: user_hdo8sp0028@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 23:47:54 | user :: user_hdo8sp0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hkbzhzcDAwMjgscj1ydk5NbXU2b2psOTR0R21raE9ZeA==</auth>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ydk5NbXU2b2psOTR0R21raE9ZeDFjcTJwTUlrbWdmRXR2ajBVODJGLHM9OTk2QThmb3NDcDhWVUE9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cnZOTW11Nm9qbDk0dEdta2hPWXgxY3EycE1Ja21nZkV0dmowVTgyRixwPWc0K1ZnandKblkzbE92SWlMaHd0VTN3ajdyT2dGS1RuaGFDZ0tOK201WUU9</response>

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

2020-05-25 23:47:54 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:54 | [Mutex] received everything.

2020-05-25 23:47:54 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:54 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:54 | user :: user_hdo8sp0028@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 23:47:54 | user :: user_hdo8sp0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hkbzhzcDAwMjgscj1OVUVDWmlzbVRDbVMyWUpGQmxUMg==</auth>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OVUVDWmlzbVRDbVMyWUpGQmxUMk9GYWdaT3Z5azlOTkZaTUtEY0NSLHM9OTk2QThmb3NDcDhWVUE9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:54 | user :: user_hdo8sp0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TlVFQ1ppc21UQ21TMllKRkJsVDJPRmFnWk92eWs5Tk5GWk1LRGNDUixwPTA0bi9qMFBTTmFWUDlUdkt0Y2dRRzhwSHNDZ3RTcVE5Tm9OV3VYOUFDSjg9</response>

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

2020-05-25 23:47:54 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:54 | [Mutex] received everything.

2020-05-25 23:47:54 | [Mutex] isItemNotified: authFailed :: true

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

2020-05-25 23:47:55 | user :: user_hdo8sp0028@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 23:47:55 | user :: user_hdo8sp0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2hkbzhzcDAwMjgscj1laDdCcm1QcUZMWllOWVJ0bVNWMg==</auth>

2020-05-25 23:47:55 | user :: user_hdo8sp0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1laDdCcm1QcUZMWllOWVJ0bVNWMkdTVVB5RHNwZUlwbHFlT0kyMGxWLHM9OTk2QThmb3NDcDhWVUE9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:55 | user :: user_hdo8sp0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZWg3QnJtUHFGTFpZTllSdG1TVjJHU1VQeURzcGVJcGxxZU9JMjBsVixwPXlVZXpwQmN0anlZVENqeXZvZjI1c3FqRWV0aVVJUEhQbFd2UFZQczBVRm89</response>

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

2020-05-25 23:47:57 | [Mutex] waiting for: [user]

2020-05-25 23:47:57 | [Mutex] received everything.

2020-05-25 23:47:57 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.270s
2020-05-25 23:47:57 |

2020-05-25 23:47:57 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-05-25 23:47:57 | ------------------------------------

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7964fb5f

2020-05-25 23:47:57 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@f286bbd}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@77a31a03}, 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@739c902f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@369e1038}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@68feabb7}, 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 23:47:57 PDT 2020}}}}

2020-05-25 23:47:57 | [Mutex] waiting for: [registration]

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7e2c7a9

2020-05-25 23:47:57 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@77a31a03}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@739c902f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@369e1038}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@68feabb7}, 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 23:47:57 PDT 2020}}}}

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@10682292

2020-05-25 23:47:57 | 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 23:47:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@56b1ef77}

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

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

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4b0f4505

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5a410c42

2020-05-25 23:47:57 | 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 23:47:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@b6cc92a}

2020-05-25 23:47:57 | 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 23:47:57 | user :: null >> <iq to="localhost" id="EFKAEGnPPL1q9rY4jDxyhEr" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-05-25 23:47:57 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@47348b9}

2020-05-25 23:47:57 | user :: null << <iq id="EFKAEGnPPL1q9rY4jDxyhEr" xmlns="jabber:client" type="result" from="localhost"><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 label="Username" var="username" type="text-single"><required/><value/></field><field label="Password" var="password" type="text-private"><required/><value/></field><field label="Email (MUST BE VALID!)" var="email" type="text-single"><required/><value/></field></x></query></iq>

2020-05-25 23:47:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@52ff5567}

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@63691550

2020-05-25 23:47:57 | user :: null >> <iq to="localhost" id="OYDnQONBtq18pTNX38ucr16" type="set"><query xmlns="jabber:iq:register"><username>user_wuk7zp0029</username><password>user_wuk7zp0029</password><email>1f5a628d-ad01-4733-a803-aab945851144@localhost</email></query></iq>

2020-05-25 23:47:57 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b451405}

2020-05-25 23:47:57 | user :: null << <iq id="OYDnQONBtq18pTNX38ucr16" xmlns="jabber:client" type="result" from="localhost"/>

2020-05-25 23:47:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@31183663}

2020-05-25 23:47:57 | [Mutex] received everything.

2020-05-25 23:47:57 | [Mutex] isItemNotified: registrationSuccess :: true

2020-05-25 23:47:57 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@56b1ef77, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@b6cc92a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@77a31a03}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@739c902f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@369e1038}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@68feabb7}, 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 23:47:57 PDT 2020}}}}

2020-05-25 23:47:57 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@56b1ef77, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@b6cc92a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@77a31a03}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@739c902f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@369e1038}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@68feabb7}, 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 23:47:57 PDT 2020}}}}

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5c509cf3

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@74acbe73

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5fc4e623

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2f1f7896

2020-05-25 23:47:57 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@77f0de82

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

2020-05-25 23:47:57 | user :: user_wuk7zp0029@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 23:47:57 | user :: user_wuk7zp0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3d1azd6cDAwMjkscj1zQTJsSW0ycXNMMXlXd2pwRGhwUQ==</auth>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zQTJsSW0ycXNMMXlXd2pwRGhwUUZuZ09lY0I1ZUg1Y1V4TTBkWUd4LHM9UHkzWUJCTllLcHk1V3c9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c0EybEltMnFzTDF5V3dqcERocFFGbmdPZWNCNWVINWNVeE0wZFlHeCxwPXVXRGFTQXh0Ylk2M1lIc2tzd2o4RTZQeTIwemtZN2hwUmZZUzRTUnF1RFk9</response>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1QODBjTnBuR1JLYkFqRzIwWnBqU2N6RC9aZ3B4U1EyeWlQU2F0enVZSjljPQ==</success>

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

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost >> <iq xmlns="jabber:client" id="pabv6lLxr14mWVZ2bnSeQHt" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost << <iq to="user_wuk7zp0029@localhost/2095755800-tigase-21" id="pabv6lLxr14mWVZ2bnSeQHt" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_wuk7zp0029@localhost/2095755800-tigase-21</jid></bind></iq>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost/2095755800-tigase-21 >> <iq xmlns="jabber:client" id="eShDLU7nQONBtq18pTNX38u" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost/2095755800-tigase-21 << <iq to="user_wuk7zp0029@localhost/2095755800-tigase-21" id="eShDLU7nQONBtq18pTNX38u" xmlns="jabber:client" type="result"/>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost/2095755800-tigase-21 >> <iq to="localhost" id="BRcqXVYqet1dxzwlPKCpPVk" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost/2095755800-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost/2095755800-tigase-21 << <enabled resume="true" id="8d7794ec-3ddb-451f-ba02-0f157ef02e83" xmlns="urn:xmpp:sm:3" max="60" location="9585556aacac"/>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost/2095755800-tigase-21 >> <iq id="U0BEt2dv1pXW6qTVUVRQaIr" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost/2095755800-tigase-21 << <iq to="user_wuk7zp0029@localhost/2095755800-tigase-21" id="BRcqXVYqet1dxzwlPKCpPVk" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@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 23:47:57 | user :: user_wuk7zp0029@localhost/2095755800-tigase-21 << <iq to="user_wuk7zp0029@localhost/2095755800-tigase-21" id="U0BEt2dv1pXW6qTVUVRQaIr" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 23:47:57 | Disconnecting

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

2020-05-25 23:47:57 | [Mutex] notify: [disconnected]

2020-05-25 23:47:57 | [Mutex] received everything.

2020-05-25 23:47:57 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:57 | user :: user_wuk7zp0029@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 23:47:57 | user :: user_wuk7zp0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3d1azd6cDAwMjkscj0yaDlNVVlqcUllSUtyS3YyZUFBTw==</auth>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yaDlNVVlqcUllSUtyS3YyZUFBT3NOakpFamNMdXBjczVqRHFSOVRzLHM9UHkzWUJCTllLcHk1V3c9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:57 | user :: user_wuk7zp0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Mmg5TVVZanFJZUlLckt2MmVBQU9zTmpKRWpjTHVwY3M1akRxUjlUcyxwPVl1cmNiU2lFd2NQRnBMd0ZyZVFtcUlKSEhiVEd4bkQ0YzhXZVFURHVoVDQ9</response>

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

2020-05-25 23:47:57 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:57 | [Mutex] received everything.

2020-05-25 23:47:57 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:57 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:57 | user :: user_wuk7zp0029@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 23:47:57 | user :: user_wuk7zp0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfd3VrN3pwMDAyOQAgLSAtIC0gLSAt</auth>

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

2020-05-25 23:47:57 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:57 | [Mutex] received everything.

2020-05-25 23:47:57 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:57 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:58 | user :: user_wuk7zp0029@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 23:47:58 | user :: user_wuk7zp0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3d1azd6cDAwMjkscj1yMFFXeEpiajlxTHRzQWR2ZGZWUg==</auth>

2020-05-25 23:47:58 | user :: user_wuk7zp0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yMFFXeEpiajlxTHRzQWR2ZGZWUkdqSHlWdHlWcE9xMkM4eWhTT3pGLHM9cFlid2NYakRYR3FWOEE9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:58 | user :: user_wuk7zp0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cjBRV3hKYmo5cUx0c0FkdmRmVlJHakh5VnR5VnBPcTJDOHloU096RixwPXEzbTg3SDhrSC9Qem1vSE93WWlaM3FXSEoxQT0=</response>

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

2020-05-25 23:47:58 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:58 | [Mutex] received everything.

2020-05-25 23:47:58 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:47:58 | [Mutex] waiting for: [event]

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

2020-05-25 23:47:58 | user :: user_wuk7zp0029@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 23:47:58 | user :: user_wuk7zp0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3d1azd6cDAwMjkscj03YlZJOGpPdlhmd1MxVEN0dkRtRw==</auth>

2020-05-25 23:47:58 | user :: user_wuk7zp0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03YlZJOGpPdlhmd1MxVEN0dkRtRzNjMHVFVnU4Y29wOFVoNlB2VEZaLHM9cFlid2NYakRYR3FWOEE9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:58 | user :: user_wuk7zp0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N2JWSThqT3ZYZndTMVRDdHZEbUczYzB1RVZ1OGNvcDhVaDZQdlRGWixwPUR6UUtRL1Q2TWFHQ09weFRXdWp2aTd3emhzaz0=</response>

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

2020-05-25 23:47:58 | [Mutex] notify: [event, authFailed]

2020-05-25 23:47:58 | [Mutex] received everything.

2020-05-25 23:47:58 | [Mutex] isItemNotified: authFailed :: true

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

2020-05-25 23:47:58 | user :: user_wuk7zp0029@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 23:47:58 | user :: user_wuk7zp0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3d1azd6cDAwMjkscj0wV0NzRTN4VnpWcmxGdHB6cUtpSQ==</auth>

2020-05-25 23:47:58 | user :: user_wuk7zp0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wV0NzRTN4VnpWcmxGdHB6cUtpSU80bW5IZU1XZXRDTjEwTVQ1Y2ZhLHM9UHkzWUJCTllLcHk1V3c9PSxpPTQwOTY=</challenge>

2020-05-25 23:47:58 | user :: user_wuk7zp0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MFdDc0UzeFZ6VnJsRnRwenFLaUlPNG1uSGVNV2V0Q04xME1UNWNmYSxwPXFHdjVjL1AwUjk0UWlGYUEzR0N0aEpMNGtSTDNxWE9xeEFJbnRLOVplOWM9</response>

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

2020-05-25 23:48:00 | [Mutex] waiting for: [user]

2020-05-25 23:48:00 | [Mutex] received everything.

2020-05-25 23:48:00 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.192s
2020-05-25 23:48:00 |

2020-05-25 23:48:00 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2020-05-25 23:48:00 | ------------------------------------

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1c25f018

2020-05-25 23:48:00 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@f286bbd}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12e20dec}, 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@16dd9b68}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@53df07d7}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@60498884}, 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 23:48:00 PDT 2020}}}}

2020-05-25 23:48:00 | [Mutex] waiting for: [registration]

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6246740c

2020-05-25 23:48:00 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12e20dec}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@16dd9b68}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@53df07d7}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@60498884}, 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 23:48:00 PDT 2020}}}}

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@183aa5f7

2020-05-25 23:48:00 | 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 23:48:00 | 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 23:48:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33f0f898}

2020-05-25 23:48:00 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1f515bca

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4ee6ba38

2020-05-25 23:48:00 | 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 23:48:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33eab0e}

2020-05-25 23:48:00 | 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 23:48:00 | user :: null >> <iq to="localhost" id="qXmMHtXhHq4mLFoTNIUcpTX" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-05-25 23:48:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7eb44261}

2020-05-25 23:48:00 | user :: null << <iq id="qXmMHtXhHq4mLFoTNIUcpTX" xmlns="jabber:client" type="result" from="localhost"><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 label="Username" var="username" type="text-single"><required/><value/></field><field label="Password" var="password" type="text-private"><required/><value/></field><field label="Email (MUST BE VALID!)" var="email" type="text-single"><required/><value/></field></x></query></iq>

2020-05-25 23:48:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@37bea7c9}

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@222435ff

2020-05-25 23:48:00 | user :: null >> <iq to="localhost" id="ZS59FtYay9rWZZ6GKv5lN5y" type="set"><query xmlns="jabber:iq:register"><username>user_1ifv3h0030</username><password>user_1ifv3h0030</password><email>3091f95e-a18b-4d3f-aaf2-99e370baa4e6@localhost</email></query></iq>

2020-05-25 23:48:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f1b24a8}

2020-05-25 23:48:00 | user :: null << <iq id="ZS59FtYay9rWZZ6GKv5lN5y" xmlns="jabber:client" type="result" from="localhost"/>

2020-05-25 23:48:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@59e86cf9}

2020-05-25 23:48:00 | [Mutex] received everything.

2020-05-25 23:48:00 | [Mutex] isItemNotified: registrationSuccess :: true

2020-05-25 23:48:00 | 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;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33f0f898, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33eab0e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12e20dec}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@16dd9b68}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@53df07d7}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@60498884}, 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 23:48:00 PDT 2020}}}}

2020-05-25 23:48:00 | 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;@f286bbd}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33f0f898, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33eab0e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12e20dec}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4e156186}, 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@16dd9b68}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@53df07d7}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@60498884}, 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 23:48:00 PDT 2020}}}}

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2f78da11

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6dbaa0d8

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6eb2fb5d

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@7427ddd6

2020-05-25 23:48:00 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1de62911

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

2020-05-25 23:48:00 | user :: user_1ifv3h0030@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 23:48:00 | user :: user_1ifv3h0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzFpZnYzaDAwMzAscj1xMHpyYURqSFZMUGk3WHFHUndvNQ==</auth>

2020-05-25 23:48:00 | user :: user_1ifv3h0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xMHpyYURqSFZMUGk3WHFHUndvNXVDTkpBbDJSTXp5RXk5dXR0UmUyLHM9ZCtOT0l3Q2ErcHMvSmc9PSxpPTQwOTY=</challenge>

2020-05-25 23:48:00 | user :: user_1ifv3h0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cTB6cmFEakhWTFBpN1hxR1J3bzV1Q05KQWwyUk16eUV5OXV0dFJlMixwPXNZdGZZaGRuekNIYWVLTU5PRjFJMGZ1ckxHWm9kb1FNN2hSZERpV1dydlU9</response>

2020-05-25 23:48:00 | user :: user_1ifv3h0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1FR3h0Y1NpOWhRcWtSODlXdUJmY2srWDlYWm9sRlovY3ZFUDRNaW5HTzN3PQ==</success>

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

2020-05-25 23:48:00 | user :: user_1ifv3h0030@localhost >> <iq xmlns="jabber:client" id="fVcR6v9oUZZfY7kNFl3fwgK" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2020-05-25 23:48:00 | user :: user_1ifv3h0030@localhost/2095755800-tigase-22 << <iq to="user_1ifv3h0030@localhost/2095755800-tigase-22" id="W0pSTRJPNCs8jLAhzg0oNFv" xmlns="jabber:client" type="result"/>

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

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

2020-05-25 23:48:00 | user :: user_1ifv3h0030@localhost/2095755800-tigase-22 >> <iq id="z5Abv4fv8KSLBnRdOVZ4gHp" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 23:48:00 | user :: user_1ifv3h0030@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 23:48:00 | user :: user_1ifv3h0030@localhost/2095755800-tigase-22 << <enabled resume="true" id="93d6baa6-3802-415b-af7d-69d884f75db8" xmlns="urn:xmpp:sm:3" max="60" location="9585556aacac"/>

2020-05-25 23:48:00 | user :: user_1ifv3h0030@localhost/2095755800-tigase-22 << <iq to="user_1ifv3h0030@localhost/2095755800-tigase-22" id="XWbt13t5cCsX3arTUiYXZ9p" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

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

2020-05-25 23:48:00 | Disconnecting

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

2020-05-25 23:48:00 | [Mutex] notify: [disconnected]

2020-05-25 23:48:00 | [Mutex] received everything.

2020-05-25 23:48:00 | [Mutex] waiting for: [event]

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

2020-05-25 23:48:01 | user :: user_1ifv3h0030@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 23:48:01 | user :: user_1ifv3h0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzFpZnYzaDAwMzAscj0xTHdkYmN0OEZyYzlHcjhpVUlEZQ==</auth>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xTHdkYmN0OEZyYzlHcjhpVUlEZWhjTWo0clpjM3JuNVY4VEZFaWtHLHM9ZCtOT0l3Q2ErcHMvSmc9PSxpPTQwOTY=</challenge>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MUx3ZGJjdDhGcmM5R3I4aVVJRGVoY01qNHJaYzNybjVWOFRGRWlrRyxwPXMwdVlNcWwwdVlVWGhTSTcyUXhGVzhPSVBjcGxjeW5CY24wM3BRYUxZVEE9</response>

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

2020-05-25 23:48:01 | [Mutex] notify: [event, authFailed]

2020-05-25 23:48:01 | [Mutex] received everything.

2020-05-25 23:48:01 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:48:01 | [Mutex] waiting for: [event]

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

2020-05-25 23:48:01 | user :: user_1ifv3h0030@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 23:48:01 | user :: user_1ifv3h0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzFpZnYzaDAwMzAscj1QQ2RReXhtWUZEdmpzVVhmVDVmZg==</auth>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QQ2RReXhtWUZEdmpzVVhmVDVmZjloNG9vaTlCSHpuN21QcnI1UnZULHM9ZCtOT0l3Q2ErcHMvSmc9PSxpPTQwOTY=</challenge>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UENkUXl4bVlGRHZqc1VYZlQ1ZmY5aDRvb2k5Qkh6bjdtUHJyNVJ2VCxwPVF0a2RGK0JKaXl4V09ITC9jMmtES3BSRmR3UktGZEtVVkRqVTBtdW9lTGs9</response>

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

2020-05-25 23:48:01 | [Mutex] notify: [event, authFailed]

2020-05-25 23:48:01 | [Mutex] received everything.

2020-05-25 23:48:01 | [Mutex] isItemNotified: authFailed :: true

2020-05-25 23:48:01 | [Mutex] waiting for: [event]

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

2020-05-25 23:48:01 | user :: user_1ifv3h0030@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 23:48:01 | user :: user_1ifv3h0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzFpZnYzaDAwMzAscj03TEpiYTZvdEh5Q0p2R0tPSG5ENA==</auth>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03TEpiYTZvdEh5Q0p2R0tPSG5ENGx6ZjVwYmlWU3lpNzhYZ1M2aUJELHM9ZCtOT0l3Q2ErcHMvSmc9PSxpPTQwOTY=</challenge>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N0xKYmE2b3RIeUNKdkdLT0huRDRsemY1cGJpVlN5aTc4WGdTNmlCRCxwPUJWNmV0UEc1UWtlWHJwSUxLeWVyampaTVlwOVkxbXBlRjdCZEpvS2JUeHc9</response>

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

2020-05-25 23:48:01 | [Mutex] notify: [event, authFailed]

2020-05-25 23:48:01 | [Mutex] received everything.

2020-05-25 23:48:01 | [Mutex] isItemNotified: authFailed :: true

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

2020-05-25 23:48:01 | user :: user_1ifv3h0030@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 23:48:01 | user :: user_1ifv3h0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzFpZnYzaDAwMzAscj1oT0xIM3RQbWsyMHV2emVtaDAySQ==</auth>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oT0xIM3RQbWsyMHV2emVtaDAySTN0azAxZ1A3VTFDaW1rN01RSVdvLHM9ZCtOT0l3Q2ErcHMvSmc9PSxpPTQwOTY=</challenge>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aE9MSDN0UG1rMjB1dnplbWgwMkkzdGswMWdQN1UxQ2ltazdNUUlXbyxwPWJXMjVMRjlpamF4Q1I4bXRZYjhpN0tFUEpoWmtaOTRGb2lTVXgzSmFERzQ9</response>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj10WHh2QmZsZngycmpFaTdTREZXMHdyMTdRcWh0K1RvNGNTbFhJY25hK2NRPQ==</success>

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

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost >> <iq xmlns="jabber:client" id="uTYhHq4mLFoTNIUcpTX1xsd" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost/2095755800-tigase-23 >> <iq xmlns="jabber:client" id="nUZdUZ4hDhVZ0eGpXY37mcM" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost/2095755800-tigase-23 << <iq to="user_1ifv3h0030@localhost/2095755800-tigase-23" id="nUZdUZ4hDhVZ0eGpXY37mcM" xmlns="jabber:client" type="result"/>

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

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

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost/2095755800-tigase-23 << <enabled resume="true" id="e381f12a-c325-493b-98b6-9655f6d21a80" xmlns="urn:xmpp:sm:3" max="60" location="9585556aacac"/>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost/2095755800-tigase-23 >> <iq id="q6v4hDhVZ0eGpXY37mcMzdB" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@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 23:48:01 | user :: user_1ifv3h0030@localhost/2095755800-tigase-23 << <iq to="user_1ifv3h0030@localhost/2095755800-tigase-23" id="nV0fY7kNFl3fwgKxdu5busi" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-05-25 23:48:01 | user :: user_1ifv3h0030@localhost/2095755800-tigase-23 << <iq to="user_1ifv3h0030@localhost/2095755800-tigase-23" id="q6v4hDhVZ0eGpXY37mcMzdB" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2020-05-25 23:48:01 | Disconnecting

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

2020-05-25 23:48:01 | [Mutex] notify: [disconnected]

2020-05-25 23:48:01 | [Mutex] received everything.

2020-05-25 23:48:03 | [Mutex] waiting for: [user]

2020-05-25 23:48:03 | [Mutex] received everything.

2020-05-25 23:48:03 | [Mutex] isItemNotified: user:ok:true :: true