Brute Force Prevention

Test duration: 15.393s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.821s
2019-11-21 03:46:23 |

2019-11-21 03:46:23 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-21 03:46:23 | ------------------------------------

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5ea53f4f

2019-11-21 03:46:23 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5062caeb}, 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@545d543f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@115fc0d0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6677caf3}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:23 PST 2019}}}}

2019-11-21 03:46:23 | [Mutex] waiting for: [registration]

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@20847144

2019-11-21 03:46:23 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5062caeb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@545d543f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@115fc0d0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6677caf3}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:23 PST 2019}}}}

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@1e4625c7

2019-11-21 03:46:23 | 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>]

2019-11-21 03:46:23 | 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>

2019-11-21 03:46:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@71703f9f}

2019-11-21 03:46:23 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:23 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@29084310

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2a051924

2019-11-21 03:46:23 | 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>

2019-11-21 03:46:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@54269be}

2019-11-21 03:46:23 | 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>]

2019-11-21 03:46:23 | user :: null >> <iq to="localhost" id="IsDeAfAlNXU9ChQ12rZkUQ3" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-21 03:46:23 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6b97e5b0}

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

2019-11-21 03:46:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@753e224e}

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1e45ef3a

2019-11-21 03:46:23 | user :: null >> <iq to="localhost" id="FpsePIqY18rZlGHIteNAxbI" type="set"><query xmlns="jabber:iq:register"><username>user_kvam920027</username><password>user_kvam920027</password><email>43fd2510-b00a-4e02-818e-e3064a280993@localhost</email></query></iq>

2019-11-21 03:46:23 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@91f4b84e}

2019-11-21 03:46:23 | user :: null << <iq xmlns="jabber:client" from="localhost" type="result" id="FpsePIqY18rZlGHIteNAxbI"/>

2019-11-21 03:46:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1c8b09ef}

2019-11-21 03:46:23 | [Mutex] received everything.

2019-11-21 03:46:23 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-21 03:46:23 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@71703f9f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@54269be]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5062caeb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@545d543f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@115fc0d0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6677caf3}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:23 PST 2019}}}}

2019-11-21 03:46:23 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@71703f9f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@54269be]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5062caeb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@545d543f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@115fc0d0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6677caf3}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:23 PST 2019}}}}

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@a928c59

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@ebae317

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3f37f1c5

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7b3743bd

2019-11-21 03:46:23 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@65d9e8c6

2019-11-21 03:46:23 | user :: user_kvam920027@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>

2019-11-21 03:46:23 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:23 | user :: user_kvam920027@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>

2019-11-21 03:46:23 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1DbG1tTGpLR3FncEh2clg1SXhQSw==</auth>

2019-11-21 03:46:23 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DbG1tTGpLR3FncEh2clg1SXhQS3d4dDhhS2pvaXhFVkRoMzBqdEZqLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:23 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q2xtbUxqS0dxZ3BIdnJYNUl4UEt3eHQ4YUtqb2l4RVZEaDMwanRGaixwPWJFNCs4QVdid2NqdXdEdHl3aDRmcEd1Mk9OaUtkaDNzcjVBY3Z1TSt6Z2M9</response>

2019-11-21 03:46:23 | user :: user_kvam920027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1lanFkYlV3NmwreERjQ0ZiM0xRVGtiREo1bVpqWXN6elRPUHladmVFZ2FrPQ==</success>

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

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <iq xmlns="jabber:client" id="CtCp12qduY4dwdxrS5u1kZY" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-21 03:46:24 | user :: user_kvam920027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" to="user_kvam920027@localhost/993927746-tigase-19" type="result" id="bOBes29oX1pOXeviVQ3dMOE"/>

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

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

2019-11-21 03:46:24 | user :: user_kvam920027@localhost/993927746-tigase-19 >> <iq id="3ARPZ1fHo8DkEqVW3dNAvkH" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-21 03:46:24 | user :: user_kvam920027@localhost/993927746-tigase-19 << <enabled id="f54d2146-6a0c-439f-b53f-d5c6026280e6" resume="true" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" to="user_kvam920027@localhost/993927746-tigase-19" from="localhost" type="result" id="RNwkHGHo9paAcLBzfDBfHBc"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10587/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10587/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" to="user_kvam920027@localhost/993927746-tigase-19" type="result" id="3ARPZ1fHo8DkEqVW3dNAvkH"><query xmlns="jabber:iq:roster"/></iq>

2019-11-21 03:46:24 | Disconnecting

2019-11-21 03:46:24 | [Mutex] notify: [disconnected]

2019-11-21 03:46:24 | [Mutex] received everything.

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

2019-11-21 03:46:24 | [Mutex] waiting for: [event]

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1VWEM5MThCb3BkYTRSWHRpWW02Rg==</auth>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VWEM5MThCb3BkYTRSWHRpWW02RmQ0bGhnUnRGRDV1MTdyYTNhZk1XLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VVhDOTE4Qm9wZGE0Ulh0aVltNkZkNGxoZ1J0RkQ1dTE3cmEzYWZNVyxwPTk2bUJpazRNT3MrS1dwUkhUNDhnT3N2eDlYV3lBZU9HWGloQVJtRWhtOGs9</response>

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

2019-11-21 03:46:24 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:24 | [Mutex] notify: [event, disconnected]

2019-11-21 03:46:24 | [Mutex] received everything.

2019-11-21 03:46:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:24 | [Mutex] waiting for: [event]

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1BTXlSM01Yb2o1d1ZObFRkbDJ0NQ==</auth>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BTXlSM01Yb2o1d1ZObFRkbDJ0NWhoUEVPQVJmZFlWRm0wVlpySnI4LHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QU15UjNNWG9qNXdWTmxUZGwydDVoaFBFT0FSZmRZVkZtMFZackpyOCxwPTZyNTkzZFBWR3hqQkJ2eGNFRUE4ZWlJbWVXUlVRNUp6V3FiSGM2b0d6L0E9</response>

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

2019-11-21 03:46:24 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:24 | [Mutex] received everything.

2019-11-21 03:46:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:24 | [Mutex] waiting for: [event]

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1rTkphdXo0Wk83emZRUE1uQVY5Rg==</auth>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rTkphdXo0Wk83emZRUE1uQVY5RmZ0MHR1Y1V2WUNhMEhPYjhLR0RKLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a05KYXV6NFpPN3pmUVBNbkFWOUZmdDB0dWNVdllDYTBIT2I4S0dESixwPUZ3UnFrck9YN2Ira3czZXY1S1lhUG5QVXlPbERWS0loYjE1UFZXRXZXRUU9</response>

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

2019-11-21 03:46:24 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:24 | [Mutex] received everything.

2019-11-21 03:46:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:24 | [Mutex] notify: [event, disconnected]

2019-11-21 03:46:24 | [Mutex] waiting for: [event]

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1RclYxd2dURFRLYWVpOWxVaHg2Tw==</auth>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RclYxd2dURFRLYWVpOWxVaHg2T3FjcjlPSGJOSFoyY0NoRHFRUExqLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UXJWMXdnVERUS2FlaTlsVWh4Nk9xY3I5T0hiTkhaMmNDaERxUVBMaixwPTEwc1Z6TUR6Q1ZnbzF6OUhrUmZpZGFFOVRVTytzbXJHQWJGZG5RNDd0eGM9</response>

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

2019-11-21 03:46:24 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:24 | [Mutex] received everything.

2019-11-21 03:46:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:24 | [Mutex] notify: [event, disconnected]

2019-11-21 03:46:24 | [Mutex] waiting for: [event]

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1vRU1HVmV5NDRweGNsMEhsZjJPOQ==</auth>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vRU1HVmV5NDRweGNsMEhsZjJPOU5DYkU3UUtNZTRCMHhzWWhya0U3LHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b0VNR1ZleTQ0cHhjbDBIbGYyTzlOQ2JFN1FLTWU0QjB4c1locmtFNyxwPTFPaDROVGIvMWY3NWRIdXpPVXpVS0NhZFNVK01kaWxXK3BudHJpRnlqK1k9</response>

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

2019-11-21 03:46:24 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:24 | [Mutex] received everything.

2019-11-21 03:46:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:24 | [Mutex] waiting for: [event]

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:24 | user :: user_kvam920027@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>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1xbjQ1SnJnYjBoTWZScW5ncjJWTw==</auth>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xbjQ1SnJnYjBoTWZScW5ncjJWT3pKSEVodGZ0MW1mM3UycU9mSzllLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:24 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cW40NUpyZ2IwaE1mUnFuZ3IyVk96SkhFaHRmdDFtZjN1MnFPZks5ZSxwPTlRTmFHRlo2OUx4ZDlTQVhpVkJremlqV1RPSmwzV0hDczdGOGJTSml3dmM9</response>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:25 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:25 | [Mutex] received everything.

2019-11-21 03:46:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:25 | [Mutex] notify: [event, disconnected]

2019-11-21 03:46:25 | [Mutex] waiting for: [event]

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1qWFZrRlVpWU1TSUFad3gzQkRwMQ==</auth>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qWFZrRlVpWU1TSUFad3gzQkRwMUJscjhVZHpvUkdJbW1ldHVKS2h2LHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9alhWa0ZVaVlNU0lBWnd4M0JEcDFCbHI4VWR6b1JHSW1tZXR1SktodixwPWJHcDhYTC9KMm10ak9VbzdmT2hYQjZ6K2VtVXdCUStzNWc2TE0zc3YzR0k9</response>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:25 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:25 | [Mutex] received everything.

2019-11-21 03:46:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:25 | [Mutex] waiting for: [event]

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1ySDg5cmFLblJiVzFmUlhuMlJhOA==</auth>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ySDg5cmFLblJiVzFmUlhuMlJhOE1QeHNHdjhpVk1acHJUMG84VWlwLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ckg4OXJhS25SYlcxZlJYbjJSYThNUHhzR3Y4aVZNWnByVDBvOFVpcCxwPVRXVXoyZFdtUWYxWGRmYVFuM0NhN0VzcUNwcTFmd2p0NUVsUGFzWnRCdGM9</response>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:25 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:25 | [Mutex] received everything.

2019-11-21 03:46:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:25 | [Mutex] waiting for: [event]

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj0yeXo1YU1EV2VUbzJJWEphUFI1Zg==</auth>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yeXo1YU1EV2VUbzJJWEphUFI1Zmg3UXgzd1ExVzBXaWVZRk1rSFZJLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Mnl6NWFNRFdlVG8ySVhKYVBSNWZoN1F4M3dRMVcwV2llWUZNa0hWSSxwPUdGNXA5blhnT0d3aFM1c3pxY0FsZlpzOXREeTlBZ3liZnMrdGJBQnRvQmc9</response>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:25 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:25 | [Mutex] received everything.

2019-11-21 03:46:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:25 | [Mutex] waiting for: [event]

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1LMzJhWkN1dnVwZnR4WDRVRHl6Yg==</auth>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LMzJhWkN1dnVwZnR4WDRVRHl6Ylk3SjlhY0w0MUJJWk5sSjNRT2RwLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SzMyYVpDdXZ1cGZ0eFg0VUR5emJZN0o5YWNMNDFCSVpObEozUU9kcCxwPUljY2JUdGI2dlhNWjlldFBwV0lnRGkrSW55RXQ3cHhIN1BWS2dOcXBsSjA9</response>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:25 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:25 | [Mutex] received everything.

2019-11-21 03:46:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:25 | [Mutex] waiting for: [event]

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1vN0V2ZXhpbFVBc1FRUk9ydVBWSw==</auth>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vN0V2ZXhpbFVBc1FRUk9ydVBWS1JVelBGZGlLcExVUnF2dVlFNHpRLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bzdFdmV4aWxVQXNRUVJPcnVQVktSVXpQRmRpS3BMVVJxdnVZRTR6USxwPXBCM0lVVUEyRk1xd1k5OE1OamZIUWFBQVZ5aHhuZU1pN2d5LzZqbUdpM2c9</response>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:25 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:25 | [Mutex] received everything.

2019-11-21 03:46:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:25 | [Mutex] waiting for: [event]

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1qY3NZblF2bkhtWW9McEN1eDBYRA==</auth>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qY3NZblF2bkhtWW9McEN1eDBYRGQ5bXJmbEkxRGJobWxmTDRiUXJPLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9amNzWW5Rdm5IbVlvTHBDdXgwWERkOW1yZmxJMURiaG1sZkw0YlFyTyxwPXh3V3ZYYStnUVF0SDA5eHQ0Q1huYzJXTzR2TC9sdjBsWkxpeDNSN1VWNkE9</response>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:25 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:25 | [Mutex] received everything.

2019-11-21 03:46:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:25 | [Mutex] waiting for: [event]

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:25 | user :: user_kvam920027@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>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1xRFNQNlcyYk9RTFBHbzdnTkZ2OA==</auth>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xRFNQNlcyYk9RTFBHbzdnTkZ2OGhtdXNheVJ1eFllaDlBbzlvRWlMLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cURTUDZXMmJPUUxQR283Z05GdjhobXVzYXlSdXhZZWg5QW85b0VpTCxwPW9XQVU5RGhnRlE1dkV4cFA1bzI2Ukh3WGZWVjhnU1BzMnZwNEgrK2NFTUE9</response>

2019-11-21 03:46:25 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:26 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:26 | [Mutex] notify: [event, disconnected]

2019-11-21 03:46:26 | [Mutex] received everything.

2019-11-21 03:46:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:26 | [Mutex] waiting for: [event]

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1ac0J4WkRDRWJPUzg1SllTVDJIcA==</auth>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ac0J4WkRDRWJPUzg1SllTVDJIcE9VNFZwR3h2dDNsWm9JS1IzSHhsLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WnNCeFpEQ0ViT1M4NUpZU1QySHBPVTRWcEd4dnQzbFpvSUtSM0h4bCxwPVdrenFoR3pEOGt4WUVGYWxVT0cwd3pqL3hubEorMFhjUFFnazBTZzJnS1E9</response>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:26 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:26 | [Mutex] received everything.

2019-11-21 03:46:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:26 | [Mutex] notify: [event, disconnected]

2019-11-21 03:46:26 | [Mutex] waiting for: [event]

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1tV1d3cmxUY0cwNUlmeXVJWnBlTw==</auth>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tV1d3cmxUY0cwNUlmeXVJWnBlT0pwZ3IyU1BvNXYxWW90VFN2UkVkLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bVdXd3JsVGNHMDVJZnl1SVpwZU9KcGdyMlNQbzV2MVlvdFRTdlJFZCxwPU5VM3ptOC80OGlkM1dhQitnMzFVNCtaWXV3aHhlRVZmZmdWQ0YwTmlPS0k9</response>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:26 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:26 | [Mutex] received everything.

2019-11-21 03:46:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:26 | [Mutex] waiting for: [event]

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1sTkJKOWJZcmRQeDNPaGV3QThRZA==</auth>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sTkJKOWJZcmRQeDNPaGV3QThRZFI3aEphTElmODBIQzhMMUM2MGhtLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bE5CSjliWXJkUHgzT2hld0E4UWRSN2hKYUxJZjgwSEM4TDFDNjBobSxwPUJQVUZ5NkdOb05FNC8yTmZOWEJGdktEam0wUVdlam1INGdmZnVRVjJnQ0U9</response>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:26 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:26 | [Mutex] received everything.

2019-11-21 03:46:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:26 | [Mutex] waiting for: [event]

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1DMmhBSE5rOG56ZENKTW1kOUFOYQ==</auth>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DMmhBSE5rOG56ZENKTW1kOUFOYThkdzd1T0xpZTZ6em1ZZzFqV3RXLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QzJoQUhOazhuemRDSk1tZDlBTmE4ZHc3dU9MaWU2enptWWcxald0VyxwPWJnMFpxNC94NlpoZHRJMXNqSjVYblhIanFwdFdtR3FKNGl4eCtGZmxha1E9</response>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:26 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:26 | [Mutex] received everything.

2019-11-21 03:46:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:26 | [Mutex] waiting for: [event]

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1NQ3cyM3FHNkNsWFJiNWVWQk1Keg==</auth>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NQ3cyM3FHNkNsWFJiNWVWQk1KelFqZjYyMTVReUhtNHE2b253MDFULHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TUN3MjNxRzZDbFhSYjVlVkJNSnpRamY2MjE1UXlIbTRxNm9udzAxVCxwPUd0eXpBN005d25rYjY0NXRlVGRxSkVXYnBXaXh3dHhoQ1l6UzRZWHphS2s9</response>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:26 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:26 | [Mutex] notify: [event, disconnected]

2019-11-21 03:46:26 | [Mutex] received everything.

2019-11-21 03:46:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:26 | [Mutex] waiting for: [event]

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj15UnRKeVdsMmpScEhEeEthVFIxcw==</auth>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15UnRKeVdsMmpScEhEeEthVFIxc1R3NWN0YThmTWJra21SbXJDOGhFLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eVJ0SnlXbDJqUnBIRHhLYVRSMXNUdzVjdGE4Zk1ia2ttUm1yQzhoRSxwPUtqMTVRRHA1WnBiTEIvN252djlZQ3RQb3UvOWt1RkQrMFJPNHFwYm4xQlE9</response>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-21 03:46:26 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:26 | [Mutex] received everything.

2019-11-21 03:46:26 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:26 | [Mutex] waiting for: [event]

2019-11-21 03:46:26 | user :: user_kvam920027@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>

2019-11-21 03:46:26 | user :: user_kvam920027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:27 | user :: user_kvam920027@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>

2019-11-21 03:46:27 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1lVDA1ZmZFaGtoY05BZ0xZTVp2RA==</auth>

2019-11-21 03:46:27 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lVDA1ZmZFaGtoY05BZ0xZTVp2RGk0ejhIUDlCQ1plMHkxRTUzaktBLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:27 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZVQwNWZmRWhraGNOQWdMWU1adkRpNHo4SFA5QkNaZTB5MUU1M2pLQSxwPTFkUExlSUZGc293azZMditRdmdwVmgrYWdZNjdvcW9wRHpSSjkzemNUeU09</response>

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

2019-11-21 03:46:27 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:27 | [Mutex] received everything.

2019-11-21 03:46:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:27 | [Mutex] waiting for: [event]

2019-11-21 03:46:27 | user :: user_kvam920027@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>

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

2019-11-21 03:46:27 | user :: user_kvam920027@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>

2019-11-21 03:46:27 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1BYXRuN2VYR0ZrazlJTVduNW5MTQ==</auth>

2019-11-21 03:46:27 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BYXRuN2VYR0ZrazlJTVduNW5MTW1GcXp2ZXNEeVhVeG9oRllMRzhSLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:27 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QWF0bjdlWEdGa2s5SU1XbjVuTE1tRnF6dmVzRHlYVXhvaEZZTEc4UixwPVhjak04N0FFRTlhMHRMRk1lUWZtdCs2NGhmUDlWL0JZV3pmWnlTcy8vK1E9</response>

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

2019-11-21 03:46:27 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:27 | [Mutex] received everything.

2019-11-21 03:46:27 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:27 | user :: user_kvam920027@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>

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

2019-11-21 03:46:27 | user :: user_kvam920027@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>

2019-11-21 03:46:27 | user :: user_kvam920027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2t2YW05MjAwMjcscj1neDB3UVQ1V2lPV0swa2dGTXlZYw==</auth>

2019-11-21 03:46:27 | user :: user_kvam920027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1neDB3UVQ1V2lPV0swa2dGTXlZY3B3eFhxeTVZTnpKdnhZMDhXRUdSLHM9Vlo0Tkp0MU5iVVRJL3c9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:27 | user :: user_kvam920027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z3gwd1FUNVdpT1dLMGtnRk15WWNwd3hYcXk1WU56SnZ4WTA4V0VHUixwPXA2bTNPc1c2WWNsZ05pemN3OWcvOFppaFRPTVFPMTFxOTJnZzl1NUZ0YmM9</response>

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

2019-11-21 03:46:29 | [Mutex] waiting for: [user]

2019-11-21 03:46:29 | [Mutex] received everything.

2019-11-21 03:46:29 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.177s
2019-11-21 03:46:29 |

2019-11-21 03:46:29 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-21 03:46:29 | ------------------------------------

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@51c3ac48

2019-11-21 03:46:29 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5f044800}, 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@5b3bc738}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1e39423b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52540c58}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:29 PST 2019}}}}

2019-11-21 03:46:29 | [Mutex] waiting for: [registration]

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2f6d1a5a

2019-11-21 03:46:29 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5f044800}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@5b3bc738}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1e39423b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52540c58}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:29 PST 2019}}}}

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2aea0a88

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

2019-11-21 03:46:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7e16bd74}

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

2019-11-21 03:46:29 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:29 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@c525822

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@4b2a3c38

2019-11-21 03:46:29 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-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>

2019-11-21 03:46:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31eec19f}

2019-11-21 03:46:29 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-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>]

2019-11-21 03:46:29 | user :: null >> <iq to="localhost" id="iDU9iVan2pOZ5wiCBhVX3rV" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-21 03:46:29 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c15c5bb7}

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

2019-11-21 03:46:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7a5827cb}

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@64d5f3ea

2019-11-21 03:46:29 | user :: null >> <iq to="localhost" id="pSBaHvmYYjHLDp9lTZYiXYW" type="set"><query xmlns="jabber:iq:register"><username>user_xy32i00028</username><password>user_xy32i00028</password><email>09378f28-1c50-4dee-8547-336d82ead22c@localhost</email></query></iq>

2019-11-21 03:46:29 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@95fcb251}

2019-11-21 03:46:29 | user :: null << <iq xmlns="jabber:client" from="localhost" type="result" id="pSBaHvmYYjHLDp9lTZYiXYW"/>

2019-11-21 03:46:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7e04c8b4}

2019-11-21 03:46:29 | [Mutex] received everything.

2019-11-21 03:46:29 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-21 03:46:29 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7e16bd74, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31eec19f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5f044800}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@5b3bc738}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1e39423b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52540c58}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:29 PST 2019}}}}

2019-11-21 03:46:29 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7e16bd74, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31eec19f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5f044800}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@5b3bc738}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1e39423b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52540c58}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:29 PST 2019}}}}

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@39a11cd2

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@27c0252

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@49fdfb54

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@11e4dbb7

2019-11-21 03:46:29 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@209212d5

2019-11-21 03:46:29 | user :: user_xy32i00028@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>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:29 | user :: user_xy32i00028@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>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h5MzJpMDAwMjgscj1icHliYW9KQ2dIRmZSdEo1MEhFNw==</auth>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1icHliYW9KQ2dIRmZSdEo1MEhFN1JmbnR0Zk9LbjRXanZ3SlpwVnhjLHM9UXBSYjV5YjROQThlZ0E9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YnB5YmFvSkNnSEZmUnRKNTBIRTdSZm50dGZPS240V2p2d0pacFZ4YyxwPU5pbjc1aU9sOFB5UkUvTm00TU9XaEJESE1sSkFKM0swam1pOUY3TTVFOUk9</response>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1PQVZmblVCMmJqWmdoSm92R0dscHpJU2djQ3FCcUpaRUhyV2l4ZDlrRXBRPQ==</success>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="2tp/q0iZDbq1z+CS1yFGZIkNy2A=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost >> <iq xmlns="jabber:client" id="hJ8l36xoPWdqdxq6ePJPLFF" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" to="user_xy32i00028@localhost/993927746-tigase-20" type="result" id="QzCxoPWdqdxq6ePJPLFFnX7"/>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost/993927746-tigase-20 >> <iq to="localhost" id="qADBjYcqdvnRR39vdqcLAas" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost/993927746-tigase-20 << <enabled id="927ea6a9-7d13-4cba-be6c-c21edd53487b" resume="true" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost/993927746-tigase-20 >> <iq id="eJ27kPLTMT6fMTMVXgMAx9F" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" to="user_xy32i00028@localhost/993927746-tigase-20" from="localhost" type="result" id="qADBjYcqdvnRR39vdqcLAas"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10587/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10587/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

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

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" to="user_xy32i00028@localhost/993927746-tigase-20" type="result" id="eJ27kPLTMT6fMTMVXgMAx9F"><query xmlns="jabber:iq:roster"/></iq>

2019-11-21 03:46:29 | Disconnecting

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

2019-11-21 03:46:29 | [Mutex] notify: [disconnected]

2019-11-21 03:46:29 | [Mutex] received everything.

2019-11-21 03:46:29 | [Mutex] waiting for: [event]

2019-11-21 03:46:29 | user :: user_xy32i00028@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>

2019-11-21 03:46:29 | user :: user_xy32i00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:30 | user :: user_xy32i00028@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>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h5MzJpMDAwMjgscj1vQmpaVGtTeXhVcEl5cEhUMVFjbw==</auth>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vQmpaVGtTeXhVcEl5cEhUMVFjb3poUVZQVG1id0pOTElYQktqcEFFLHM9UXBSYjV5YjROQThlZ0E9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b0JqWlRrU3l4VXBJeXBIVDFRY296aFFWUFRtYndKTkxJWEJLanBBRSxwPTNJSUcvcE9pb3A4Q2xCbDNLRVZvZC9XZDJCNnBnQzlxZFdmamhDR2N1eDQ9</response>

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

2019-11-21 03:46:30 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:30 | [Mutex] received everything.

2019-11-21 03:46:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:30 | [Mutex] waiting for: [event]

2019-11-21 03:46:30 | user :: user_xy32i00028@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>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:30 | user :: user_xy32i00028@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>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h5MzJpMDAwMjgscj1rTm0zOEFUR1YyRFpmVFhpblhUTQ==</auth>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rTm0zOEFUR1YyRFpmVFhpblhUTWdNTVRhYTBNOUswcThoT1pFTDNCLHM9UXBSYjV5YjROQThlZ0E9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a05tMzhBVEdWMkRaZlRYaW5YVE1nTU1UYWEwTTlLMHE4aE9aRUwzQixwPWdXdWdaZ2x3U291TkRlRFlnQk0ycnkzUGJ2RDJNMlVabmFvamVlc0dwUE09</response>

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

2019-11-21 03:46:30 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:30 | [Mutex] received everything.

2019-11-21 03:46:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:30 | [Mutex] waiting for: [event]

2019-11-21 03:46:30 | user :: user_xy32i00028@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>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:30 | user :: user_xy32i00028@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>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h5MzJpMDAwMjgscj1DOEdnTFJlWGxSNmRnRHliT09mMQ==</auth>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DOEdnTFJlWGxSNmRnRHliT09mMVE0ZElTdlRMc29YdnFoUnh0T2V6LHM9UXBSYjV5YjROQThlZ0E9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QzhHZ0xSZVhsUjZkZ0R5Yk9PZjFRNGRJU3ZUTHNvWHZxaFJ4dE9leixwPWtYZVU2WEJNVUwyRmExUThPSzI1c0pXbkZTZ3lxRnkrKzNHUUVMQTVvM1E9</response>

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

2019-11-21 03:46:30 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:30 | [Mutex] received everything.

2019-11-21 03:46:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:30 | [Mutex] waiting for: [event]

2019-11-21 03:46:30 | user :: user_xy32i00028@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>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:30 | user :: user_xy32i00028@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>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h5MzJpMDAwMjgscj1Hb3c1dGd0QTdxcFNzUEJna1BrWA==</auth>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Hb3c1dGd0QTdxcFNzUEJna1BrWExJNmxoc3NsVkZ2ZjZVa1FUSGFmLHM9UXBSYjV5YjROQThlZ0E9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R293NXRndEE3cXBTc1BCZ2tQa1hMSTZsaHNzbFZGdmY2VWtRVEhhZixwPUd0SU5XaWtOODFzcmVSbzZNM0NsYkorK0lqOWNPZnhhZ1ZwWFR1Y25zNTg9</response>

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

2019-11-21 03:46:30 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:30 | [Mutex] received everything.

2019-11-21 03:46:30 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:30 | user :: user_xy32i00028@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>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:30 | user :: user_xy32i00028@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>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h5MzJpMDAwMjgscj1QQ29MQnZ2SGpSeVlaN3AyY2JwYw==</auth>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QQ29MQnZ2SGpSeVlaN3AyY2JwYzRyZ0MxakxrblY0cUZhcUhremFBLHM9UXBSYjV5YjROQThlZ0E9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:30 | user :: user_xy32i00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UENvTEJ2dkhqUnlZWjdwMmNicGM0cmdDMWpMa25WNHFGYXFIa3phQSxwPU1Canc0aFNIKzFRcXplK0R3YldVSWpVdHRTZ2VzUHhTU3E0M1dPN2xNQzg9</response>

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

2019-11-21 03:46:32 | [Mutex] waiting for: [user]

2019-11-21 03:46:32 | [Mutex] received everything.

2019-11-21 03:46:32 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.139s
2019-11-21 03:46:32 |

2019-11-21 03:46:32 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-21 03:46:32 | ------------------------------------

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@567e36dc

2019-11-21 03:46:32 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@58b9c263}, 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@5c865dac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1984c858}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3eebc562}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:32 PST 2019}}}}

2019-11-21 03:46:32 | [Mutex] waiting for: [registration]

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2857b206

2019-11-21 03:46:32 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@58b9c263}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@5c865dac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1984c858}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3eebc562}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:32 PST 2019}}}}

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@46d2e19d

2019-11-21 03:46:32 | 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>

2019-11-21 03:46:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@79ab3717}

2019-11-21 03:46:32 | 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>]

2019-11-21 03:46:32 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:32 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@190b2d95

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@c596b30

2019-11-21 03:46:32 | 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>]

2019-11-21 03:46:32 | 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>

2019-11-21 03:46:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5dd6ad2f}

2019-11-21 03:46:32 | user :: null >> <iq to="localhost" id="NPexrS5u1kZYjJOSMVVdxdL" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-21 03:46:32 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c81449f2}

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

2019-11-21 03:46:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7de52a0d}

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3dc2d7a1

2019-11-21 03:46:32 | user :: null >> <iq to="localhost" id="w2PHLDp9lTZYiXYW05gHvnK" type="set"><query xmlns="jabber:iq:register"><username>user_jkuh310029</username><password>user_jkuh310029</password><email>95fcdcd0-1256-43df-83bf-41379d24e640@localhost</email></query></iq>

2019-11-21 03:46:32 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5036bfec}

2019-11-21 03:46:32 | user :: null << <iq xmlns="jabber:client" from="localhost" type="result" id="w2PHLDp9lTZYiXYW05gHvnK"/>

2019-11-21 03:46:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7a852bc2}

2019-11-21 03:46:32 | [Mutex] received everything.

2019-11-21 03:46:32 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-21 03:46:32 | 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;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@79ab3717, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5dd6ad2f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@58b9c263}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@5c865dac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1984c858}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3eebc562}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:32 PST 2019}}}}

2019-11-21 03:46:32 | 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;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@79ab3717, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5dd6ad2f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@58b9c263}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@5c865dac}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1984c858}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3eebc562}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:32 PST 2019}}}}

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@12525e68

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@4633bb6d

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6de713d5

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3eefee90

2019-11-21 03:46:32 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3e4e563b

2019-11-21 03:46:32 | user :: user_jkuh310029@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>

2019-11-21 03:46:32 | user :: user_jkuh310029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:32 | user :: user_jkuh310029@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>

2019-11-21 03:46:32 | user :: user_jkuh310029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2prdWgzMTAwMjkscj10UmR3QzZPMmVNa2ZrQmxrZ0hCbQ==</auth>

2019-11-21 03:46:32 | user :: user_jkuh310029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10UmR3QzZPMmVNa2ZrQmxrZ0hCbWFNVWRlZEFzU3I3cVJRVUxkQTRGLHM9VmY5NDFGZmkzNGgrTGc9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:32 | user :: user_jkuh310029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFJkd0M2TzJlTWtma0Jsa2dIQm1hTVVkZWRBc1NyN3FSUVVMZEE0RixwPXNGMjFIZERUbVpIUnlrOVFiVzFQbGRHSlRPZlVlZGpIem9pMkZ6WXFIaFU9</response>

2019-11-21 03:46:32 | user :: user_jkuh310029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1RQlEvOFM0bnd4NlExNlA0YXVhSy9oRWJLOWVJQTRpcjJZTkVORU9IL3BjPQ==</success>

2019-11-21 03:46:32 | user :: user_jkuh310029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="2tp/q0iZDbq1z+CS1yFGZIkNy2A=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <iq xmlns="jabber:client" id="9GJMVUOKzeDn7eNUR0lGJzu" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost << <iq xmlns="jabber:client" to="user_jkuh310029@localhost/993927746-tigase-21" type="result" id="9GJMVUOKzeDn7eNUR0lGJzu"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_jkuh310029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="iO5v0l03o7ePLS02rXhFthB" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" to="user_jkuh310029@localhost/993927746-tigase-21" type="result" id="iO5v0l03o7ePLS02rXhFthB"/>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost/993927746-tigase-21 >> <iq to="localhost" id="r5SP0gyt1pVZjFxhyshCeAf" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost/993927746-tigase-21 >> <iq id="zQ7l15nXUaHsUWX0btjCzsX" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost/993927746-tigase-21 << <enabled id="603d5ab1-b8e5-48ee-8580-8e03cc3ba722" resume="true" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

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

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" to="user_jkuh310029@localhost/993927746-tigase-21" from="localhost" type="result" id="r5SP0gyt1pVZjFxhyshCeAf"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10587/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10587/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" to="user_jkuh310029@localhost/993927746-tigase-21" type="result" id="zQ7l15nXUaHsUWX0btjCzsX"><query xmlns="jabber:iq:roster"/></iq>

2019-11-21 03:46:33 | Disconnecting

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

2019-11-21 03:46:33 | [Mutex] notify: [disconnected]

2019-11-21 03:46:33 | [Mutex] received everything.

2019-11-21 03:46:33 | [Mutex] waiting for: [event]

2019-11-21 03:46:33 | user :: user_jkuh310029@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>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:33 | user :: user_jkuh310029@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>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2prdWgzMTAwMjkscj1SanF0REZXbUhvZUJHSnI5OVRVMg==</auth>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SanF0REZXbUhvZUJHSnI5OVRVMjJUOTNaemZ2MFpPbXpoeVRGY1ZRLHM9VmY5NDFGZmkzNGgrTGc9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UmpxdERGV21Ib2VCR0pyOTlUVTIyVDkzWnpmdjBaT216aHlURmNWUSxwPUJheVp3cEdhc0R0aFpMblBIL1hyUFBNSDNmR2o0SW91SmJGYWQvUmxiQUk9</response>

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

2019-11-21 03:46:33 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:33 | [Mutex] notify: [event, disconnected]

2019-11-21 03:46:33 | [Mutex] received everything.

2019-11-21 03:46:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:33 | [Mutex] waiting for: [event]

2019-11-21 03:46:33 | user :: user_jkuh310029@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>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:33 | user :: user_jkuh310029@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>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2prdWgzMTAwMjkscj1RZHZoU2xWS2NhOEdLRkw3bGpRTA==</auth>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RZHZoU2xWS2NhOEdLRkw3bGpRTGljdFp3aDBVZXZ1cjdyRGdxSWtQLHM9VmY5NDFGZmkzNGgrTGc9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UWR2aFNsVktjYThHS0ZMN2xqUUxpY3Rad2gwVWV2dXI3ckRncUlrUCxwPXpkMTh3RmpNNytKdDg0UXI4QkRtZ0tkeU0yb1NINmxRcjZmQm1lUHNHNkk9</response>

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

2019-11-21 03:46:33 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:33 | [Mutex] received everything.

2019-11-21 03:46:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:33 | [Mutex] waiting for: [event]

2019-11-21 03:46:33 | user :: user_jkuh310029@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>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:33 | user :: user_jkuh310029@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>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2prdWgzMTAwMjkscj02ZFkzRTFJREJ4VzNMbWx1ZFBCVg==</auth>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02ZFkzRTFJREJ4VzNMbWx1ZFBCVjVHdlNsMjk4eTVqb0tWWU5rQTBRLHM9VmY5NDFGZmkzNGgrTGc9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NmRZM0UxSURCeFczTG1sdWRQQlY1R3ZTbDI5OHk1am9LVllOa0EwUSxwPURYMm5POTdYZFo4Qjh1SUJ5eFcrWkhyaGZQbWc1K01yeEovWnU2UW1wWTA9</response>

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

2019-11-21 03:46:33 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:33 | [Mutex] received everything.

2019-11-21 03:46:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:33 | [Mutex] waiting for: [event]

2019-11-21 03:46:33 | user :: user_jkuh310029@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>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:33 | user :: user_jkuh310029@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>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2prdWgzMTAwMjkscj1IWFdrOHFhdG5la1hZbXgxMUhkdA==</auth>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IWFdrOHFhdG5la1hZbXgxMUhkdGdhNXA1V0RaekNYSXRPTWlObDh1LHM9VmY5NDFGZmkzNGgrTGc9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SFhXazhxYXRuZWtYWW14MTFIZHRnYTVwNVdEWnpDWEl0T01pTmw4dSxwPUV1UFdZQ1p2RzgzUkRkVnlhbGxKeTNhTW5FWlpvK054Umpwd3UweU5JOEU9</response>

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

2019-11-21 03:46:33 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:33 | [Mutex] received everything.

2019-11-21 03:46:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:33 | user :: user_jkuh310029@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>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:33 | user :: user_jkuh310029@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>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2prdWgzMTAwMjkscj01UTFFdXNrYmJPdjRvUlJUcVE5eA==</auth>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01UTFFdXNrYmJPdjRvUlJUcVE5eHk2TllCZHNaUURXR1E5SGNGV1VmLHM9VmY5NDFGZmkzNGgrTGc9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:33 | user :: user_jkuh310029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NVExRXVza2JiT3Y0b1JSVHFROXh5Nk5ZQmRzWlFEV0dROUhjRldVZixwPWlWYkhMZDBxT3lZNFE0K2lHYmZGVEJNblhWVVNIaXAvYmViMklNR1cvM3c9</response>

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

2019-11-21 03:46:35 | [Mutex] waiting for: [user]

2019-11-21 03:46:35 | [Mutex] received everything.

2019-11-21 03:46:35 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 2.974s
2019-11-21 03:46:35 |

2019-11-21 03:46:35 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-21 03:46:35 | ------------------------------------

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4894b694

2019-11-21 03:46:35 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@465351f6}, 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@426cdde4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76e5bcd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6a236da2}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:35 PST 2019}}}}

2019-11-21 03:46:35 | [Mutex] waiting for: [registration]

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@36235df1

2019-11-21 03:46:35 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@465351f6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@426cdde4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76e5bcd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6a236da2}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:35 PST 2019}}}}

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@1284352c

2019-11-21 03:46:35 | 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>]

2019-11-21 03:46:35 | 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>

2019-11-21 03:46:35 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6741a482}

2019-11-21 03:46:35 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:35 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@167e8bb5

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3a1e805e

2019-11-21 03:46:35 | 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>

2019-11-21 03:46:35 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@980ff64}

2019-11-21 03:46:35 | 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>]

2019-11-21 03:46:35 | user :: null >> <iq to="localhost" id="qMPZ5wiCBhVX3rV3jCAx8gE" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-21 03:46:35 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d26031c8}

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

2019-11-21 03:46:35 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@630f3f62}

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@14e3395

2019-11-21 03:46:35 | user :: null >> <iq to="localhost" id="70t7eOZ24gBiLDDgR27wnKR" type="set"><query xmlns="jabber:iq:register"><username>user_vesrd70030</username><password>user_vesrd70030</password><email>82e7acfb-6cd6-40ca-8949-f2a9cc42f7ee@localhost</email></query></iq>

2019-11-21 03:46:35 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a2bb66d2}

2019-11-21 03:46:35 | user :: null << <iq xmlns="jabber:client" from="localhost" type="result" id="70t7eOZ24gBiLDDgR27wnKR"/>

2019-11-21 03:46:35 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4f9c5f92}

2019-11-21 03:46:35 | [Mutex] received everything.

2019-11-21 03:46:35 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-21 03:46:35 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6741a482, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@980ff64]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@465351f6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@426cdde4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76e5bcd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6a236da2}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:35 PST 2019}}}}

2019-11-21 03:46:35 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6741a482, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@980ff64]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@465351f6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@426cdde4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76e5bcd}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6a236da2}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Nov 21 03:46:35 PST 2019}}}}

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4169e2da

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@5b8731ba

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2b2573c4

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@668d9fd

2019-11-21 03:46:35 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@81994d8

2019-11-21 03:46:35 | user :: user_vesrd70030@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>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:36 | user :: user_vesrd70030@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>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Zlc3JkNzAwMzAscj1WOWxOVDVsajJSaWpibXE1b0hjYQ==</auth>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WOWxOVDVsajJSaWpibXE1b0hjYWJLdWNWbEZrb0hjNUsyZk9URWYxLHM9ZFR2bURWOS8wWWV3YUE9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VjlsTlQ1bGoyUmlqYm1xNW9IY2FiS3VjVmxGa29IYzVLMmZPVEVmMSxwPTdHNFdzTUh2NGtDRE1jTDVEK2x2bXRTVVZjd1I0YVJIbG9MQmpXbnltSHc9</response>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1kYVAwa2poeTQveVg2V0lnWGRjTXl6WTdVSU9lbHFsUVRDL05EUWYvVnVZPQ==</success>

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

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <iq xmlns="jabber:client" id="GaVbqQOHu9pbm3qT4tWfBym" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost << <iq xmlns="jabber:client" to="user_vesrd70030@localhost/993927746-tigase-22" type="result" id="GaVbqQOHu9pbm3qT4tWfBym"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_vesrd70030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="xU7zfDBfHBcKRMyexav7BcJ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" to="user_vesrd70030@localhost/993927746-tigase-22" type="result" id="xU7zfDBfHBcKRMyexav7BcJ"/>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-22 >> <iq to="localhost" id="gWbv7BcJMBujCBjYcqdvnRR" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-22 >> <iq id="GdYhCeAfAlNXU9ChQ12rZkU" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-22 << <enabled id="0a3f7b68-6d7d-40d5-8a46-9d4d530d8c21" resume="true" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

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

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" to="user_vesrd70030@localhost/993927746-tigase-22" from="localhost" type="result" id="gWbv7BcJMBujCBjYcqdvnRR"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10587/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10587/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" to="user_vesrd70030@localhost/993927746-tigase-22" type="result" id="GdYhCeAfAlNXU9ChQ12rZkU"><query xmlns="jabber:iq:roster"/></iq>

2019-11-21 03:46:36 | Disconnecting

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

2019-11-21 03:46:36 | [Mutex] notify: [disconnected]

2019-11-21 03:46:36 | [Mutex] received everything.

2019-11-21 03:46:36 | [Mutex] waiting for: [event]

2019-11-21 03:46:36 | user :: user_vesrd70030@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>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:36 | user :: user_vesrd70030@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>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Zlc3JkNzAwMzAscj1pN2xuRVNPa2VQMzBOdml0YzlDZA==</auth>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pN2xuRVNPa2VQMzBOdml0YzlDZHR5a215c2luNmZKN3lQeVRhbUhPLHM9ZFR2bURWOS8wWWV3YUE9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aTdsbkVTT2tlUDMwTnZpdGM5Q2R0eWtteXNpbjZmSjd5UHlUYW1ITyxwPVQvcVBTVTA4YWdpT3VYaHowTGNvY3ZoLzZiK2FVM0JvMUtncFc4T1cwTlE9</response>

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

2019-11-21 03:46:36 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:36 | [Mutex] received everything.

2019-11-21 03:46:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:36 | [Mutex] waiting for: [event]

2019-11-21 03:46:36 | user :: user_vesrd70030@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>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:36 | user :: user_vesrd70030@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>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Zlc3JkNzAwMzAscj1iZkpQclNGaUUyU3lwN3ZVOElxaQ==</auth>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iZkpQclNGaUUyU3lwN3ZVOElxaWV5S1BzUjEzQ2w5OXVmMkpoWVptLHM9ZFR2bURWOS8wWWV3YUE9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YmZKUHJTRmlFMlN5cDd2VThJcWlleUtQc1IxM0NsOTl1ZjJKaFlabSxwPUJrb0pMbS9TVERFdEdDTkVnaFp6NG9jVnBUMDV5NUJyZGd6OXNBWDYwcHM9</response>

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

2019-11-21 03:46:36 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:36 | [Mutex] received everything.

2019-11-21 03:46:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:36 | [Mutex] waiting for: [event]

2019-11-21 03:46:36 | user :: user_vesrd70030@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>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:36 | user :: user_vesrd70030@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>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Zlc3JkNzAwMzAscj16NVlzeGRtdU12cU00MGdZN2lmZw==</auth>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16NVlzeGRtdU12cU00MGdZN2lmZzF0SVB1N0VJSHVjRVhKOWF2RkpWLHM9ZFR2bURWOS8wWWV3YUE9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ejVZc3hkbXVNdnFNNDBnWTdpZmcxdElQdTdFSUh1Y0VYSjlhdkZKVixwPVR4ZWhER1kydFZqRy83S0drVStNNFVZWDBmN0l5YmFzNzRlQ0Y4aWtMdjg9</response>

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

2019-11-21 03:46:36 | [Mutex] notify: [event, authFailed]

2019-11-21 03:46:36 | [Mutex] received everything.

2019-11-21 03:46:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-21 03:46:36 | user :: user_vesrd70030@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>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-21 03:46:36 | user :: user_vesrd70030@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>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3Zlc3JkNzAwMzAscj01a2lmakUwYVU4TDREZkg1R1RiSw==</auth>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01a2lmakUwYVU4TDREZkg1R1RiS01FOWlxaVdFWG9YZVBYSHdESzRjLHM9ZFR2bURWOS8wWWV3YUE9PSxpPTQwOTY=</challenge>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NWtpZmpFMGFVOEw0RGZINUdUYktNRTlpcWlXRVhvWGVQWEh3REs0YyxwPWRhVTZzL0pEVSttanN1eUhIY08yZzh5ZWU0VXZBdGFYYU5BTE91Y1NlaVU9</response>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1lZFZUMksrTFQrc3B4Y3MydHZoMVJRYnVjNmI5cithL3QyVThZelFwQzhFPQ==</success>

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

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost >> <iq xmlns="jabber:client" id="D5yhyshCeAfAlNXU9ChQ12r" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost << <iq xmlns="jabber:client" to="user_vesrd70030@localhost/993927746-tigase-23" type="result" id="D5yhyshCeAfAlNXU9ChQ12r"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_vesrd70030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="fYbq19FkZiDyrS7l2kGJxrZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" to="user_vesrd70030@localhost/993927746-tigase-23" type="result" id="fYbq19FkZiDyrS7l2kGJxrZ"/>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-23 >> <iq to="localhost" id="Zg1gyt1pVZjFxhyshCeAfAl" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-23 << <enabled id="ed81465f-0fd6-4bfa-ad5a-139594c269da" resume="true" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-23 >> <iq id="pgZWfBymKRNX1bHr5nKQ3ak" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" to="user_vesrd70030@localhost/993927746-tigase-23" from="localhost" type="result" id="Zg1gyt1pVZjFxhyshCeAfAl"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10587/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10587/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-21 03:46:36 | user :: user_vesrd70030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" to="user_vesrd70030@localhost/993927746-tigase-23" type="result" id="pgZWfBymKRNX1bHr5nKQ3ak"><query xmlns="jabber:iq:roster"/></iq>

2019-11-21 03:46:36 | Disconnecting

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

2019-11-21 03:46:36 | [Mutex] notify: [disconnected]

2019-11-21 03:46:36 | [Mutex] received everything.

2019-11-21 03:46:38 | [Mutex] waiting for: [user]

2019-11-21 03:46:38 | [Mutex] received everything.

2019-11-21 03:46:38 | [Mutex] isItemNotified: user:ok:true :: true