Brute Force Prevention

2019-10-13 20:44:20 |

2019-10-13 20:44:20 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:44:20 | ------------------------------------

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3c073c5f

2019-10-13 20:44:20 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@32c0d5af}, 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@36ff572f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@73fddf94}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@769df070}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:20 PDT 2019}}}}

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@42c42ea1

2019-10-13 20:44:20 | [Mutex] waiting for: [registration]

2019-10-13 20:44:20 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@32c0d5af}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@36ff572f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@73fddf94}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@769df070}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:20 PDT 2019}}}}

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@e4e5ff9

2019-10-13 20:44:20 | 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-10-13 20:44:20 | 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-10-13 20:44:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@13d220db}

2019-10-13 20:44:20 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:20 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@ad55ca1

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@6987da7c

2019-10-13 20:44:20 | 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-10-13 20:44:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@154af122}

2019-10-13 20:44:20 | 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-10-13 20:44:20 | user :: null >> <iq to="localhost" id="oWCpfDxkSdUXWZnT6uZj4Bl" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:44:20 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f4036afc}

2019-10-13 20:44:20 | user :: null << <iq xmlns="jabber:client" type="result" from="localhost" id="oWCpfDxkSdUXWZnT6uZj4Bl"><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-10-13 20:44:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@179cdfa8}

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@378cb9ae

2019-10-13 20:44:20 | user :: null >> <iq to="localhost" id="LQiXaEiFLIHICFtdGADKDiH" type="set"><query xmlns="jabber:iq:register"><username>user_zii2f70019</username><password>user_zii2f70019</password><email>291bc6c6-0fc4-4e50-8544-1cb8f95d23f0@localhost</email></query></iq>

2019-10-13 20:44:20 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@95c902c9}

2019-10-13 20:44:20 | user :: null << <iq xmlns="jabber:client" type="result" from="localhost" id="LQiXaEiFLIHICFtdGADKDiH"/>

2019-10-13 20:44:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@608fd119}

2019-10-13 20:44:20 | [Mutex] received everything.

2019-10-13 20:44:20 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:44:20 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@13d220db, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@154af122]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@32c0d5af}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@36ff572f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@73fddf94}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@769df070}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:20 PDT 2019}}}}

2019-10-13 20:44:20 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@13d220db, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@154af122]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@32c0d5af}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@36ff572f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@73fddf94}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@769df070}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:20 PDT 2019}}}}

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@220effcb

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@539e05bd

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@18d97a9

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1f949998

2019-10-13 20:44:20 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@4a31dd06

2019-10-13 20:44:20 | user :: user_zii2f70019@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-10-13 20:44:20 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:20 | user :: user_zii2f70019@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-10-13 20:44:20 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj15M3RUNVFpMHlJQ2NobGlYZmFObA==</auth>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15M3RUNVFpMHlJQ2NobGlYZmFObDdQOGZ4c0lZWk11U1FSUnlPMk4xLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eTN0VDVRaTB5SUNjaGxpWGZhTmw3UDhmeHNJWVpNdVNRUlJ5TzJOMSxwPUkzQ2NGTjJyekx1YUJHZysyTFNncGdiU0kyVk5Cb3FsMHFwaENMRnlncGs9</response>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0yb2lva3ZPNm9ld2ZyRjdudU00YTVLaXFac1V6cmF2bktDZ1dCc0F4OTJnPQ==</success>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c ver="fD1ATDhYhT37hyTvdBFDDag+4EU=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost >> <iq xmlns="jabber:client" id="eOawq6w29JEzs6Dp5q4BGv2" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost << <iq to="user_zii2f70019@localhost/993927746-tigase-13" xmlns="jabber:client" type="result" id="eOawq6w29JEzs6Dp5q4BGv2"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_zii2f70019@localhost/993927746-tigase-13</jid></bind></iq>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost/993927746-tigase-13 >> <iq xmlns="jabber:client" id="UZFvr1jSYpiJu5zhS25vsnT" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost/993927746-tigase-13 << <iq to="user_zii2f70019@localhost/993927746-tigase-13" xmlns="jabber:client" type="result" id="UZFvr1jSYpiJu5zhS25vsnT"/>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost/993927746-tigase-13 >> <iq to="localhost" id="M4SZiAfV2l0cPNRYaN4hAhX" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost/993927746-tigase-13 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost/993927746-tigase-13 << <enabled resume="true" max="60" xmlns="urn:xmpp:sm:3" location="d4270859fb27" id="5e5312c1-36b0-4690-b008-1a3a385ffec4"/>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost/993927746-tigase-13 >> <iq id="va8JBezxdKMztofDDq3ueMy" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost/993927746-tigase-13 << <iq to="user_zii2f70019@localhost/993927746-tigase-13" xmlns="jabber:client" type="result" from="localhost" id="M4SZiAfV2l0cPNRYaN4hAhX"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="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-10-13 20:44:20 | user :: user_zii2f70019@localhost/993927746-tigase-13 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost/993927746-tigase-13 << <iq to="user_zii2f70019@localhost/993927746-tigase-13" xmlns="jabber:client" type="result" id="va8JBezxdKMztofDDq3ueMy"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:44:20 | Disconnecting

2019-10-13 20:44:20 | user :: user_zii2f70019@localhost/993927746-tigase-13 << <presence to="user_zii2f70019@localhost" xmlns="jabber:client" from="user_zii2f70019@localhost/993927746-tigase-13"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence>

2019-10-13 20:44:20 | [Mutex] notify: [disconnected]

2019-10-13 20:44:20 | [Mutex] received everything.

2019-10-13 20:44:20 | [Mutex] waiting for: [event]

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1qeTJlOVZPRER4YnRFU2tUOHNIZw==</auth>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qeTJlOVZPRER4YnRFU2tUOHNIZ1l3T2kxV3hCZWVnTE42dmx6S1l3LHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ankyZTlWT0REeGJ0RVNrVDhzSGdZd09pMVd4QmVlZ0xONnZsektZdyxwPWkwdjEvT1orUnM5b2VzaHFXcjVGQ2lxT2FFeC84b21ZdndlTUk4bWFyVEk9</response>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:21 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:21 | [Mutex] received everything.

2019-10-13 20:44:21 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:21 | [Mutex] notify: [event, disconnected]

2019-10-13 20:44:21 | [Mutex] waiting for: [event]

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj0wOE5WWFJmT1hpZUw0Vm11WlJYTA==</auth>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wOE5WWFJmT1hpZUw0Vm11WlJYTDU3N0FEYVlKbHlMb2laS21ralJQLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MDhOVlhSZk9YaWVMNFZtdVpSWEw1NzdBRGFZSmx5TG9pWktta2pSUCxwPU8vYlJaMHhNYUdCaVFsQ3owV3N2ZjB3RVlVdS9QMmFkN1o2M1c5ZUsyVWM9</response>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:21 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:21 | [Mutex] received everything.

2019-10-13 20:44:21 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:21 | [Mutex] waiting for: [event]

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj11S3J4WkRaTUE4eUdrY2luMlFJNQ==</auth>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11S3J4WkRaTUE4eUdrY2luMlFJNVVKaGs3bmpRVUc0Sk0xbzVMdjhoLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dUtyeFpEWk1BOHlHa2NpbjJRSTVVSmhrN25qUVVHNEpNMW81THY4aCxwPVhqQk5jT1E2ZHJyUjcyZVYwNSs5Y0pkaFcyVjVTczFRcFJzcnEwdFY1WUU9</response>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:21 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:21 | [Mutex] received everything.

2019-10-13 20:44:21 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:21 | [Mutex] waiting for: [event]

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1sOUpNclRvdVBaN2dqVUFmZExXVQ==</auth>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sOUpNclRvdVBaN2dqVUFmZExXVTNiSHhlTUppNzVtY0EwZkpCUHdyLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bDlKTXJUb3VQWjdnalVBZmRMV1UzYkh4ZU1KaTc1bWNBMGZKQlB3cixwPWtoaE1TTFRZQW05SjVKeWVzWkttUHY2YU5UcVhjOWJKaEMxTm1BazdhUG89</response>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:21 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:21 | [Mutex] received everything.

2019-10-13 20:44:21 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:21 | [Mutex] waiting for: [event]

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1XZnBXQlRYQlUzVHRmMjEydkZSUA==</auth>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XZnBXQlRYQlUzVHRmMjEydkZSUHQ2djFBcXFjNGJZMjVWeFUzVnVGLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V2ZwV0JUWEJVM1R0ZjIxMnZGUlB0NnYxQXFxYzRiWTI1VnhVM1Z1RixwPVZqSXpqOStEdyttTHFFRDR6NUU4blNFN2oyRFJEcDhNTUIyaFhoZ2VWMXM9</response>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:21 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:21 | [Mutex] notify: [event, disconnected]

2019-10-13 20:44:21 | [Mutex] received everything.

2019-10-13 20:44:21 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:21 | [Mutex] waiting for: [event]

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1uYTVVRDRuUVU2N0N1b0Y2b3lJMQ==</auth>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uYTVVRDRuUVU2N0N1b0Y2b3lJMWk2WEVHZEJIWXVBVHNLRll0NGc3LHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bmE1VUQ0blFVNjdDdW9GNm95STFpNlhFR2RCSFl1QVRzS0ZZdDRnNyxwPWFnSTJKYnBiRnhNWVd1ckFsangreXdZZ2xuTjdZd1haRytFbGVWdFk3Y009</response>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:21 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:21 | [Mutex] notify: [event, disconnected]

2019-10-13 20:44:21 | [Mutex] received everything.

2019-10-13 20:44:21 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:21 | [Mutex] waiting for: [event]

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:21 | user :: user_zii2f70019@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-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1HT1BEZmRhR3JvenFEWWc0a1FZUw==</auth>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HT1BEZmRhR3JvenFEWWc0a1FZU0xhTXVKWUk2UVhHYkNCWU0yQWNpLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R09QRGZkYUdyb3pxRFlnNGtRWVNMYU11SllJNlFYR2JDQllNMkFjaSxwPUNiTExRZTRQTVc2YTllY0E0TlNqZ2dKaE9GMy8zdXRhYTdSQUJXMlBFZ2s9</response>

2019-10-13 20:44:21 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:21 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:21 | [Mutex] received everything.

2019-10-13 20:44:21 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:22 | [Mutex] waiting for: [event]

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1YcURSWkpXdTNXUXJGMklVMUZuQQ==</auth>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YcURSWkpXdTNXUXJGMklVMUZuQXlTTWFaMjg1ZWJaZG9QUmNjOFl2LHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WHFEUlpKV3UzV1FyRjJJVTFGbkF5U01hWjI4NWViWmRvUFJjYzhZdixwPXpQR2tpcTA3RE1hTHhEOUp5dFQ1NzNrZlVjTzUxRXU2K1pER3RHQkdBY1k9</response>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:22 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:22 | [Mutex] received everything.

2019-10-13 20:44:22 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:22 | [Mutex] waiting for: [event]

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1rRWRnakJXTVQyMmQ3d2Z2MGVRWA==</auth>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rRWRnakJXTVQyMmQ3d2Z2MGVRWDZ1Z1M1R0xqNnRPdWhocDVLN0ZxLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a0VkZ2pCV01UMjJkN3dmdjBlUVg2dWdTNUdMajZ0T3VoaHA1SzdGcSxwPURkc2k5aU56TDF3VWNwbFlEbzhNVVNPYkVHaVpUc1c0VDBNd3JTOVJhL009</response>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:22 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:22 | [Mutex] received everything.

2019-10-13 20:44:22 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:22 | [Mutex] waiting for: [event]

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1zNmhoYmhreHVoVDBYYUtMNHNtcw==</auth>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zNmhoYmhreHVoVDBYYUtMNHNtc2tUSFp0RDRGSEtKWkpNZEtqS29jLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9czZoaGJoa3h1aFQwWGFLTDRzbXNrVEhadEQ0RkhLSlpKTWRLaktvYyxwPXFxYzhSeXhLREhYazhMNGFlYnNqRVVBSXJyMzZpL3h6cjRNbjNCYmFMamM9</response>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:22 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:22 | [Mutex] received everything.

2019-10-13 20:44:22 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:22 | [Mutex] waiting for: [event]

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1zUWhpbVRmN2IyeDV2cjNnRDlSdA==</auth>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zUWhpbVRmN2IyeDV2cjNnRDlSdEI5dHVuRnhwTXJxOG9aWTBwRjlPLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c1FoaW1UZjdiMng1dnIzZ0Q5UnRCOXR1bkZ4cE1ycThvWlkwcEY5TyxwPUIzdEI5M3UwRXJ3UUc4MmNGUXBSQ21pUVdIODBrdkVFRTI0Rlh4RlVsWUE9</response>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:22 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:22 | [Mutex] received everything.

2019-10-13 20:44:22 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:22 | [Mutex] waiting for: [event]

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj0yanFEVExxR1lhOVB2MFBRS2o5cg==</auth>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yanFEVExxR1lhOVB2MFBRS2o5clVrNTFEZHJzZFZxOEJtTUNjUTNqLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MmpxRFRMcUdZYTlQdjBQUUtqOXJVazUxRGRyc2RWcThCbU1DY1EzaixwPUpTdHRiS3hiZ0pSdGtBbjN6dXRzc1c1dnNQcVhhczdqZ2xISkw1T0hJVm89</response>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:22 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:22 | [Mutex] received everything.

2019-10-13 20:44:22 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:22 | [Mutex] waiting for: [event]

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1wMzlhS2pJbEozRkxTZnB1OElDNA==</auth>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wMzlhS2pJbEozRkxTZnB1OElDNDJtVmJ0bk43b0xoam01d2UxVEdkLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cDM5YUtqSWxKM0ZMU2ZwdThJQzQybVZidG5ON29MaGptNXdlMVRHZCxwPTFIM3ZVQkZyWFFCWGdLTVNzUnVNOEVJR1RGbmEvSHRQVXA0ckRlSTZQbFk9</response>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:22 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:22 | [Mutex] received everything.

2019-10-13 20:44:22 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:22 | [Mutex] waiting for: [event]

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1VN0ppQU0wMU96ZEJjbHZwVFdwWQ==</auth>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VN0ppQU0wMU96ZEJjbHZwVFdwWXdnV3I0MmRUTnBIQmxkQzJrWFhqLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VTdKaUFNMDFPemRCY2x2cFRXcFl3Z1dyNDJkVE5wSEJsZEMya1hYaixwPUlPcGlUWkRYMlQ2TDEzRHZnN1JjaXFadFBKY25YMUc4N1p1czNwT3BzbHc9</response>

2019-10-13 20:44:22 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:22 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:22 | [Mutex] received everything.

2019-10-13 20:44:22 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:22 | [Mutex] waiting for: [event]

2019-10-13 20:44:22 | user :: user_zii2f70019@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-10-13 20:44:22 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1odmdXREdKQ1Q4YWxsRUxyVThKOA==</auth>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1odmdXREdKQ1Q4YWxsRUxyVThKOGFPSEJxbGxpczJ2QnBQVkRSVnNOLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aHZnV0RHSkNUOGFsbEVMclU4SjhhT0hCcWxsaXMydkJwUFZEUlZzTixwPUhZZi92ZjJaT2JyaVhzcG9RR3kzTmJCZXBhandmTzlIdGNhVGtKWU5McEU9</response>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:23 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:23 | [Mutex] received everything.

2019-10-13 20:44:23 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:23 | [Mutex] waiting for: [event]

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1nVTVWR0FFa3Z0dHZmUTlna3dIZw==</auth>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nVTVWR0FFa3Z0dHZmUTlna3dIZzYxZHQwVFE2T2RQU1NPWWJ6TkZNLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z1U1VkdBRWt2dHR2ZlE5Z2t3SGc2MWR0MFRRNk9kUFNTT1liek5GTSxwPWJDSkpVSTNkZDNqbXNVZFV5aEFPbFMvaGs4WThESmhxMDMyTE5rY0lVdzg9</response>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:23 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:23 | [Mutex] received everything.

2019-10-13 20:44:23 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:23 | [Mutex] waiting for: [event]

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj16dmlwN3hINzVDNjI0VWk3NjNpVA==</auth>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16dmlwN3hINzVDNjI0VWk3NjNpVEtrbUJlVG1kQ2MwZ2l4NWlwTE53LHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9enZpcDd4SDc1QzYyNFVpNzYzaVRLa21CZVRtZENjMGdpeDVpcExOdyxwPXZJNm5oUEc1aE5uU1FjOGxyL0VQck9aRkN6bWVUU0Y1NnNkcVJBVDloZFU9</response>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:23 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:23 | [Mutex] received everything.

2019-10-13 20:44:23 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:23 | [Mutex] waiting for: [event]

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1aZ1pyNzVzM1U3SXpCdDg1STJoSQ==</auth>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aZ1pyNzVzM1U3SXpCdDg1STJoSTlDQUwxUEF4d05JUlJFV0dZM3haLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Wmdacjc1czNVN0l6QnQ4NUkyaEk5Q0FMMVBBeHdOSVJSRVdHWTN4WixwPWU1V2pURS95VFhyNmViSlo3MUlaY3VaUXNUeDRPRHcrOE1aUTdFa29TZjg9</response>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:23 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:23 | [Mutex] received everything.

2019-10-13 20:44:23 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:23 | [Mutex] notify: [event, disconnected]

2019-10-13 20:44:23 | [Mutex] waiting for: [event]

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj05YnNITWt2M1p6WXRvdGdDWWI0Mw==</auth>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05YnNITWt2M1p6WXRvdGdDWWI0M1FDUUhxTHdGc1VxT1hEU3FqeDNaLHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OWJzSE1rdjNaell0b3RnQ1liNDNRQ1FIcUx3RnNVcU9YRFNxangzWixwPU1lQ0RtZnE4NzRIMjAydTMzZWxiWnZET2R6YlNvN0tKZTg1RlJ6emNEODg9</response>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:23 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:23 | [Mutex] received everything.

2019-10-13 20:44:23 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:23 | [Mutex] waiting for: [event]

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1vNDRjZ29XYkRXODFjSkg1N0Zadg==</auth>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vNDRjZ29XYkRXODFjSkg1N0ZadnBwazBZMVRzT1ZQaXRGa0hBQmd1LHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bzQ0Y2dvV2JEVzgxY0pINTdGWnZwcGswWTFUc09WUGl0RmtIQUJndSxwPTFNODlFN3dvUlNTNjhjTVhoR29lMnp6dDNNTG52aWtBLzRheVdIQ2NmQjA9</response>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:23 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:23 | [Mutex] notify: [event, disconnected]

2019-10-13 20:44:23 | [Mutex] received everything.

2019-10-13 20:44:23 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:23 | [Mutex] waiting for: [event]

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1kV1c1eDZYaXBsdHAydVdPMEJ1ZA==</auth>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kV1c1eDZYaXBsdHAydVdPMEJ1ZE5IRDBQRXFEdnNZRTNNVkdZYmI5LHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZFdXNXg2WGlwbHRwMnVXTzBCdWROSEQwUEVxRHZzWUUzTVZHWWJiOSxwPU4vOFhIcjRCeXZTVnZ6V0k0OElET0l1cjdMQ0FFcTJkNVorK0VoZlpwZFk9</response>

2019-10-13 20:44:23 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:23 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:23 | [Mutex] received everything.

2019-10-13 20:44:23 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:23 | user :: user_zii2f70019@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-10-13 20:44:23 | user :: user_zii2f70019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:24 | user :: user_zii2f70019@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-10-13 20:44:24 | user :: user_zii2f70019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3ppaTJmNzAwMTkscj1YNUpWWGdudmhPWldlVVN3ZjdhbQ==</auth>

2019-10-13 20:44:24 | user :: user_zii2f70019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YNUpWWGdudmhPWldlVVN3ZjdhbTFORjE5czVqZUZlTGMwdzV2amd5LHM9MmsyODlUaEU5K0EySlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:24 | user :: user_zii2f70019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WDVKVlhnbnZoT1pXZVVTd2Y3YW0xTkYxOXM1amVGZUxjMHc1dmpneSxwPUxFamIzMi9jaDZIMFVJdE1tcHJINWI1UG1lb1pYOHdCL3E2NVV4TFlSelU9</response>

2019-10-13 20:44:24 | user :: user_zii2f70019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: user_zii2f70019@localhost is not authorized to act as user_zii2f70019@localhost</text></failure>

2019-10-13 20:44:26 | [Mutex] waiting for: [user]

2019-10-13 20:44:26 | [Mutex] received everything.

2019-10-13 20:44:26 | [Mutex] isItemNotified: user:ok:false :: true

2019-10-13 20:44:26 |

2019-10-13 20:44:26 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:44:26 | ------------------------------------

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2e2a7aa4

2019-10-13 20:44:26 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20ed8111}, 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@24d211d4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61d08b2a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c5232ee}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:26 PDT 2019}}}}

2019-10-13 20:44:26 | [Mutex] waiting for: [registration]

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@507bcd7c

2019-10-13 20:44:26 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20ed8111}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@24d211d4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61d08b2a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c5232ee}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:26 PDT 2019}}}}

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@64132a16

2019-10-13 20:44:26 | 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-10-13 20:44:26 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ff7465}

2019-10-13 20:44:26 | 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-10-13 20:44:26 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:26 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@c37f3f6

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2a9cf21

2019-10-13 20:44:26 | 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-10-13 20:44:26 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f1706f8}

2019-10-13 20:44:26 | 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-10-13 20:44:26 | user :: null >> <iq to="localhost" id="Wb5iRYaN4hAhX3q8hTeVZlQ" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:44:26 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3b701b76}

2019-10-13 20:44:26 | user :: null << <iq xmlns="jabber:client" type="result" from="localhost" id="Wb5iRYaN4hAhX3q8hTeVZlQ"><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-10-13 20:44:26 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5b10923}

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@36aaf220

2019-10-13 20:44:26 | user :: null >> <iq to="localhost" id="BUeLODBELFHyj0gQGrjOT6o" type="set"><query xmlns="jabber:iq:register"><username>user_e3o2jj0020</username><password>user_e3o2jj0020</password><email>b0837679-5048-46a6-bcf6-c114add86773@localhost</email></query></iq>

2019-10-13 20:44:26 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@cab09c3e}

2019-10-13 20:44:26 | user :: null << <iq xmlns="jabber:client" type="result" from="localhost" id="BUeLODBELFHyj0gQGrjOT6o"/>

2019-10-13 20:44:26 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7ab6e313}

2019-10-13 20:44:26 | [Mutex] received everything.

2019-10-13 20:44:26 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:44:26 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ff7465, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f1706f8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20ed8111}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@24d211d4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61d08b2a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c5232ee}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:26 PDT 2019}}}}

2019-10-13 20:44:26 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ff7465, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f1706f8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@20ed8111}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@24d211d4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61d08b2a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c5232ee}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:26 PDT 2019}}}}

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3d511a7b

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@30a4f4e3

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@51fe3b25

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1c1de472

2019-10-13 20:44:26 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@292aa748

2019-10-13 20:44:26 | user :: user_e3o2jj0020@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-10-13 20:44:26 | user :: user_e3o2jj0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@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-10-13 20:44:26 | user :: user_e3o2jj0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2UzbzJqajAwMjAscj04S0FSS2NycUlWMXdPT3g4cGczUg==</auth>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04S0FSS2NycUlWMXdPT3g4cGczUkdkTWUzVm1uN2NTRVhmeGxHeHFRLHM9ZjlaNDVXQzVKeGhzWVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OEtBUktjcnFJVjF3T094OHBnM1JHZE1lM1ZtbjdjU0VYZnhsR3hxUSxwPXpFQ1pOSUlTWnp5Qzl5ZzB5T3hEMUNqYzNLdUd1azhQT0VLOVd0WUY1NDA9</response>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ZUTZodGhCM2tHeVVkaUk5c3dkNDZ6OEZGSi9hUGhYOEdaRHpQUXRlcVBBPQ==</success>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c ver="fD1ATDhYhT37hyTvdBFDDag+4EU=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost >> <iq xmlns="jabber:client" id="mYo2oYnT3mWlatY3v9Cw3rk" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost << <iq to="user_e3o2jj0020@localhost/993927746-tigase-14" xmlns="jabber:client" type="result" id="mYo2oYnT3mWlatY3v9Cw3rk"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_e3o2jj0020@localhost/993927746-tigase-14</jid></bind></iq>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost/993927746-tigase-14 >> <iq xmlns="jabber:client" id="daW1fS0kEnbyn4k5jT2i3Aj" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost/993927746-tigase-14 << <iq to="user_e3o2jj0020@localhost/993927746-tigase-14" xmlns="jabber:client" type="result" id="daW1fS0kEnbyn4k5jT2i3Aj"/>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost/993927746-tigase-14 >> <iq to="localhost" id="2QWYlPYeth0t5xeFIGGmN1e" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost/993927746-tigase-14 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost/993927746-tigase-14 << <enabled resume="true" max="60" xmlns="urn:xmpp:sm:3" location="d4270859fb27" id="1f7efda2-97c9-4602-aa66-d74bc7749bc6"/>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost/993927746-tigase-14 >> <iq id="N5Dz8l7q7yi1bDwgZs38n9r" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost/993927746-tigase-14 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2019-10-13 20:44:26 | Disconnecting

2019-10-13 20:44:26 | [Mutex] notify: [disconnected]

2019-10-13 20:44:26 | [Mutex] received everything.

2019-10-13 20:44:26 | [Mutex] waiting for: [event]

2019-10-13 20:44:26 | user :: user_e3o2jj0020@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-10-13 20:44:26 | user :: user_e3o2jj0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@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-10-13 20:44:26 | user :: user_e3o2jj0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2UzbzJqajAwMjAscj1jenR6R0czd21adjNHaUtzNG5HZg==</auth>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jenR6R0czd21adjNHaUtzNG5HZmdjMVdsbDRxSXpaVk1pRUZscHVDLHM9ZjlaNDVXQzVKeGhzWVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y3p0ekdHM3dtWnYzR2lLczRuR2ZnYzFXbGw0cUl6WlZNaUVGbHB1QyxwPWdyQUMvVDN0TXlzYm51YU10cks0blFKVDZLbmsrZng5VjlYZGxIYThvQWM9</response>

2019-10-13 20:44:26 | user :: user_e3o2jj0020@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:26 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:26 | [Mutex] notify: [event, disconnected]

2019-10-13 20:44:26 | [Mutex] received everything.

2019-10-13 20:44:26 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:26 | [Mutex] waiting for: [event]

2019-10-13 20:44:26 | user :: user_e3o2jj0020@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-10-13 20:44:26 | user :: user_e3o2jj0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@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-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2UzbzJqajAwMjAscj1xQ2k4dXppZktFUE1FWUFMY1FpZQ==</auth>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xQ2k4dXppZktFUE1FWUFMY1FpZVZmRW84Z0FBU3E1cHgxQmxvN3dDLHM9ZjlaNDVXQzVKeGhzWVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cUNpOHV6aWZLRVBNRVlBTGNRaWVWZkVvOGdBQVNxNXB4MUJsbzd3QyxwPUptREp3VE1aVXNXaUpVd3F5WGh6MVNvcXh0VVZRNnIwWTUxOWJHa1hmbTQ9</response>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:27 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:27 | [Mutex] received everything.

2019-10-13 20:44:27 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:27 | [Mutex] waiting for: [event]

2019-10-13 20:44:27 | user :: user_e3o2jj0020@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-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@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-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2UzbzJqajAwMjAscj01TGFmMEJ6Y09nMElCdnBvaXVZYQ==</auth>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01TGFmMEJ6Y09nMElCdnBvaXVZYWFGSUVoaHZJdDNLZkhZWk1TOVBELHM9ZjlaNDVXQzVKeGhzWVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NUxhZjBCemNPZzBJQnZwb2l1WWFhRklFaGh2SXQzS2ZIWVpNUzlQRCxwPW40MVJMZFlVeGYzQ0tneEZHU2d3SmpMVXhySmovZnIvUTJsSFJnYk0yajg9</response>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:27 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:27 | [Mutex] received everything.

2019-10-13 20:44:27 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:27 | [Mutex] waiting for: [event]

2019-10-13 20:44:27 | user :: user_e3o2jj0020@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-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@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-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2UzbzJqajAwMjAscj1CcVJ5VkJmRkNJSEg2b3N0V0tocQ==</auth>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CcVJ5VkJmRkNJSEg2b3N0V0tocUNpNFh5WFJFVHR5ZlI4UUxQVkUwLHM9ZjlaNDVXQzVKeGhzWVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QnFSeVZCZkZDSUhINm9zdFdLaHFDaTRYeVhSRVR0eWZSOFFMUFZFMCxwPXZEcWdNbEhaV0dXRUpYZngvZWg2clFIbktNbFdMeGo2TDNRWGwzQ2xmbjQ9</response>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:27 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:27 | [Mutex] received everything.

2019-10-13 20:44:27 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:27 | user :: user_e3o2jj0020@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-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@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-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2UzbzJqajAwMjAscj1zUnhQVEhDYkE3ME5wV21ROE5iTA==</auth>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zUnhQVEhDYkE3ME5wV21ROE5iTFFDeGl3T2lkZWlOUmI0YVE3VFlqLHM9ZjlaNDVXQzVKeGhzWVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c1J4UFRIQ2JBNzBOcFdtUThOYkxRQ3hpd09pZGVpTlJiNGFRN1RZaixwPVMwZm9kallvL3IxNnkrS2x1cGZhVG05aVpicmFLQ2ZaZThQNzJRY28xd2s9</response>

2019-10-13 20:44:27 | user :: user_e3o2jj0020@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:29 | [Mutex] waiting for: [user]

2019-10-13 20:44:29 | [Mutex] received everything.

2019-10-13 20:44:29 | [Mutex] isItemNotified: user:ok:true :: true

2019-10-13 20:44:29 |

2019-10-13 20:44:29 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:44:29 | ------------------------------------

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@564de132

2019-10-13 20:44:29 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@588a058b}, 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@5cb58a42}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@19b70fb0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@204a39c5}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:29 PDT 2019}}}}

2019-10-13 20:44:29 | [Mutex] waiting for: [registration]

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@28e4d61a

2019-10-13 20:44:29 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@588a058b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@5cb58a42}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@19b70fb0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@204a39c5}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:29 PDT 2019}}}}

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@58f3bede

2019-10-13 20:44: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-10-13 20:44:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7998f0ff}

2019-10-13 20:44: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-10-13 20:44:29 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:29 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@8ed7a18

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@6372919

2019-10-13 20:44: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-10-13 20:44:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@43f7724f}

2019-10-13 20:44: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-10-13 20:44:29 | user :: null >> <iq to="localhost" id="r1lW8urmRKBBl0iBxwv9Fub" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:44:29 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@71d6fa6f}

2019-10-13 20:44:29 | user :: null << <iq xmlns="jabber:client" type="result" from="localhost" id="r1lW8urmRKBBl0iBxwv9Fub"><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-10-13 20:44:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7dd66dc6}

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1e88e5de

2019-10-13 20:44:29 | user :: null >> <iq to="localhost" id="DbNAvsnT9s7CuiAfV2l0cPN" type="set"><query xmlns="jabber:iq:register"><username>user_kdsq4t0021</username><password>user_kdsq4t0021</password><email>0223032c-b8b1-4c16-942d-3256000e76ea@localhost</email></query></iq>

2019-10-13 20:44:29 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@9dc5453f}

2019-10-13 20:44:29 | user :: null << <iq xmlns="jabber:client" type="result" from="localhost" id="DbNAvsnT9s7CuiAfV2l0cPN"/>

2019-10-13 20:44:29 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@21c878f7}

2019-10-13 20:44:29 | [Mutex] received everything.

2019-10-13 20:44:29 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:44:29 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7998f0ff, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@43f7724f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@588a058b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@5cb58a42}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@19b70fb0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@204a39c5}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:29 PDT 2019}}}}

2019-10-13 20:44:29 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7998f0ff, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@43f7724f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@588a058b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@5cb58a42}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@19b70fb0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@204a39c5}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:29 PDT 2019}}}}

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5955138b

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1723ed3a

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4edc5c15

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2cb19af9

2019-10-13 20:44:29 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5d091daf

2019-10-13 20:44:29 | user :: user_kdsq4t0021@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-10-13 20:44:29 | user :: user_kdsq4t0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:29 | user :: user_kdsq4t0021@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-10-13 20:44:29 | user :: user_kdsq4t0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tkc3E0dDAwMjEscj1yNUZmTnl6Q0dIaUJHSVM0aFBVeg==</auth>

2019-10-13 20:44:29 | user :: user_kdsq4t0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yNUZmTnl6Q0dIaUJHSVM0aFBVemI3RmJBUXhJZ3pqbEkyeXdhN2p4LHM9Y05SQXl1MmFSclNCZlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cjVGZk55ekNHSGlCR0lTNGhQVXpiN0ZiQVF4SWd6amxJMnl3YTdqeCxwPVdBMk42eUFyNndIRGw5UVp3K2t1Q21LRUxzb0JESXA4a1RuVTZBTlRqQnM9</response>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0rK3BuY3dQL3FBdDdraFdhbXVFU2NlMnpDdFZjU2RCbStEMy9hOVJMSmlVPQ==</success>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c ver="fD1ATDhYhT37hyTvdBFDDag+4EU=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <iq xmlns="jabber:client" id="YbLLKXoVSR7n4qR3yzhV0dO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <iq to="user_kdsq4t0021@localhost/993927746-tigase-15" xmlns="jabber:client" type="result" id="YbLLKXoVSR7n4qR3yzhV0dO"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_kdsq4t0021@localhost/993927746-tigase-15</jid></bind></iq>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost/993927746-tigase-15 >> <iq xmlns="jabber:client" id="FgYndzvaxsaEiFLIHICFtdG" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost/993927746-tigase-15 << <iq to="user_kdsq4t0021@localhost/993927746-tigase-15" xmlns="jabber:client" type="result" id="FgYndzvaxsaEiFLIHICFtdG"/>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost/993927746-tigase-15 >> <iq to="localhost" id="lnhJJMKVZfKITgFmP3fOUPZ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost/993927746-tigase-15 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost/993927746-tigase-15 >> <iq id="wrr02bLFEAbHQ9rfEvo2oMD" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost/993927746-tigase-15 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost/993927746-tigase-15 << <enabled resume="true" max="60" xmlns="urn:xmpp:sm:3" location="d4270859fb27" id="5c8cb61f-b19d-403b-b424-261e333d8a77"/>

2019-10-13 20:44:30 | Disconnecting

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

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost/993927746-tigase-15 << <presence to="user_kdsq4t0021@localhost" xmlns="jabber:client" from="user_kdsq4t0021@localhost/993927746-tigase-15"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence>

2019-10-13 20:44:30 | [Mutex] notify: [disconnected]

2019-10-13 20:44:30 | [Mutex] received everything.

2019-10-13 20:44:30 | [Mutex] waiting for: [event]

2019-10-13 20:44:30 | user :: user_kdsq4t0021@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-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@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-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tkc3E0dDAwMjEscj1wWlZqSUtyak9qZlllbVdtZnBkaw==</auth>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wWlZqSUtyak9qZlllbVdtZnBka2c4QXd1ZVdobzFCbVZxSFJaTlJ3LHM9Y05SQXl1MmFSclNCZlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cFpWaklLcmpPamZZZW1XbWZwZGtnOEF3dWVXaG8xQm1WcUhSWk5SdyxwPXJiMStyTlZYSDJNWVNhMVVDZ21qSlFWaGMzS1FMcyt6MlRMc3NobjFTYUE9</response>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:30 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:30 | [Mutex] received everything.

2019-10-13 20:44:30 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:30 | [Mutex] waiting for: [event]

2019-10-13 20:44:30 | user :: user_kdsq4t0021@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-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@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-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2tkc3E0dDAwMjEscj1MZG9sUXpyQ0VFYUwwOWQxQzV1RA==</auth>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MZG9sUXpyQ0VFYUwwOWQxQzV1RElteERiaGl3NEprV1JPYWZUMEVLLHM9VHFramZZTnNqNzY5L0E9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TGRvbFF6ckNFRWFMMDlkMUM1dURJbXhEYmhpdzRKa1dST2FmVDBFSyxwPVFUa01BQzRFU3ZQQVNWdDd6elFTcjVlSm5IRT0=</response>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:30 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:30 | [Mutex] received everything.

2019-10-13 20:44:30 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:30 | [Mutex] waiting for: [event]

2019-10-13 20:44:30 | user :: user_kdsq4t0021@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-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@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-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tkc3E0dDAwMjEscj1UWDRxbm0yZWx2Zmo0YjJYa2Y3bg==</auth>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UWDRxbm0yZWx2Zmo0YjJYa2Y3bmFyM3pGQXFuWnAwa2QzSFQ4UUNMLHM9Y05SQXl1MmFSclNCZlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VFg0cW5tMmVsdmZqNGIyWGtmN25hcjN6RkFxblpwMGtkM0hUOFFDTCxwPW8xTTluWGlpOWZRRDN5ZXJoY216TTRQTkZteEViQUQxY3VkR1N6VnRiT3M9</response>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:30 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:30 | [Mutex] received everything.

2019-10-13 20:44:30 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:30 | [Mutex] waiting for: [event]

2019-10-13 20:44:30 | user :: user_kdsq4t0021@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-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@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-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tkc3E0dDAwMjEscj1ZcU1yYW1SZk9pS1BtNUp5U3A2RA==</auth>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZcU1yYW1SZk9pS1BtNUp5U3A2RGFKS1lvNG5qUnVZMHBWTTBIVFFrLHM9Y05SQXl1MmFSclNCZlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WXFNcmFtUmZPaUtQbTVKeVNwNkRhSktZbzRualJ1WTBwVk0wSFRRayxwPVptWWoveHppdDhQN3l2Vkg2QkJOMWRTNldiSWVzVWVENlVoUkI2aEVkc1U9</response>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:30 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:30 | [Mutex] received everything.

2019-10-13 20:44:30 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:30 | user :: user_kdsq4t0021@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-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@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-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tkc3E0dDAwMjEscj03bUtacWdMdDFqY0VrTUNmYXQyOA==</auth>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03bUtacWdMdDFqY0VrTUNmYXQyOG5XaXBYZ1k5ZE1TNjlSUlNmMkR0LHM9Y05SQXl1MmFSclNCZlE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N21LWnFnTHQxamNFa01DZmF0MjhuV2lwWGdZOWRNUzY5UlJTZjJEdCxwPVpCcXlYNE84REN5MWNUYWNteWZObkExQzdzREZqOWFtN1djcGNYR3VHbDA9</response>

2019-10-13 20:44:30 | user :: user_kdsq4t0021@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:32 | [Mutex] waiting for: [user]

2019-10-13 20:44:32 | [Mutex] received everything.

2019-10-13 20:44:32 | [Mutex] isItemNotified: user:ok:true :: true

2019-10-13 20:44:32 |

2019-10-13 20:44:32 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:44:32 | ------------------------------------

2019-10-13 20:44:32 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@52d88f4

2019-10-13 20:44:32 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@bea6621}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@fd5e384}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4ad76c1a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2354279c}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:32 PDT 2019}}}}

2019-10-13 20:44:32 | [Mutex] waiting for: [registration]

2019-10-13 20:44:32 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7bd786b9

2019-10-13 20:44:32 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@bea6621}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@fd5e384}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4ad76c1a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2354279c}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:32 PDT 2019}}}}

2019-10-13 20:44:32 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@5bbe9384

2019-10-13 20:44: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-10-13 20:44:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2af89355}

2019-10-13 20:44: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-10-13 20:44:32 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:32 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 20:44:32 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@28922951

2019-10-13 20:44:32 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@6f3790b4

2019-10-13 20:44: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-10-13 20:44:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@40ba1c65}

2019-10-13 20:44: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-10-13 20:44:32 | user :: null >> <iq to="localhost" id="7iUOXmbvnU1q6w29JEzs6Dp" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:44:32 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@41493ffe}

2019-10-13 20:44:32 | user :: null << <iq xmlns="jabber:client" type="result" from="localhost" id="7iUOXmbvnU1q6w29JEzs6Dp"><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-10-13 20:44:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2eb64d1c}

2019-10-13 20:44:32 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1757313a

2019-10-13 20:44:32 | user :: null >> <iq to="localhost" id="0vw9kLVZiSLRaNJPOP2kYWX" type="set"><query xmlns="jabber:iq:register"><username>user_3h8qc80022</username><password>user_3h8qc80022</password><email>0acc81e6-8fe9-4283-af6e-bb3a494c1c63@localhost</email></query></iq>

2019-10-13 20:44:32 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@98b6315d}

2019-10-13 20:44:33 | user :: null << <iq xmlns="jabber:client" type="result" from="localhost" id="0vw9kLVZiSLRaNJPOP2kYWX"/>

2019-10-13 20:44:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@44b6b154}

2019-10-13 20:44:33 | [Mutex] received everything.

2019-10-13 20:44:33 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:44:33 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2af89355, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@40ba1c65]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@bea6621}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@fd5e384}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4ad76c1a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2354279c}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:33 PDT 2019}}}}

2019-10-13 20:44:33 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@60b91e33}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2af89355, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@40ba1c65]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@bea6621}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@21841408}, 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@fd5e384}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4ad76c1a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2354279c}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Oct 13 20:44:33 PDT 2019}}}}

2019-10-13 20:44:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@547fd493

2019-10-13 20:44:33 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@483dbdad

2019-10-13 20:44:33 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@664d8b71

2019-10-13 20:44:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1780bafd

2019-10-13 20:44:33 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3d712fd2

2019-10-13 20:44:33 | user :: user_3h8qc80022@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-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@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-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNoOHFjODAwMjIscj0wSU5TQ3BEem52dWxyQ2V1MExncQ==</auth>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wSU5TQ3BEem52dWxyQ2V1MExncVdxWmUxUUJ1NFVmdzBnaXptTEhkLHM9UWY2R1phaCtOTXc2aEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MElOU0NwRHpudnVsckNldTBMZ3FXcVplMVFCdTRVZncwZ2l6bUxIZCxwPWJGaFZQTW9iV2FBTkRNT3NLRlAyTkNWeUpldVo1TzY5UldYdnZZd3NXU3M9</response>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0vN2NSb2d2Y0txVW1WVGo3L2tLQVk3YysxQUhiWTFGVy82cUFnRkN2b3h3PQ==</success>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c ver="fD1ATDhYhT37hyTvdBFDDag+4EU=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <iq xmlns="jabber:client" id="njU6odzp4mbQPGtlPYeth0t" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <iq to="user_3h8qc80022@localhost/993927746-tigase-16" xmlns="jabber:client" type="result" id="njU6odzp4mbQPGtlPYeth0t"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_3h8qc80022@localhost/993927746-tigase-16</jid></bind></iq>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-16 >> <iq xmlns="jabber:client" id="Hwv7BmVeIKu3xgNU0r1jSYp" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-16 << <iq to="user_3h8qc80022@localhost/993927746-tigase-16" xmlns="jabber:client" type="result" id="Hwv7BmVeIKu3xgNU0r1jSYp"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-16 >> <iq to="localhost" id="zbshHIIrdSdzvaxsaEiFLIH" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-16 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-16 << <enabled resume="true" max="60" xmlns="urn:xmpp:sm:3" location="d4270859fb27" id="6469b7c4-a8ca-4670-9c93-f158d3b681fb"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-16 >> <iq id="Bezq8hTeVZlQTaAuY1t8xoY" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-16 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2019-10-13 20:44:33 | Disconnecting

2019-10-13 20:44:33 | [Mutex] notify: [disconnected]

2019-10-13 20:44:33 | [Mutex] received everything.

2019-10-13 20:44:33 | [Mutex] waiting for: [event]

2019-10-13 20:44:33 | user :: user_3h8qc80022@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-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@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-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNoOHFjODAwMjIscj1SR1lrVFM4dXJaMnZlNEhGTmNQbA==</auth>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SR1lrVFM4dXJaMnZlNEhGTmNQbGpXemh6UUNCaGVhYWtTZkRrd25vLHM9UWY2R1phaCtOTXc2aEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UkdZa1RTOHVyWjJ2ZTRIRk5jUGxqV3poelFDQmhlYWFrU2ZEa3dubyxwPW42aXVsYzh4VmVIdGlRQWx1U3FPSUt5bkZYMTlHSmw1YmkzZVpOOHVITGs9</response>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:33 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:33 | [Mutex] received everything.

2019-10-13 20:44:33 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:33 | [Mutex] waiting for: [event]

2019-10-13 20:44:33 | user :: user_3h8qc80022@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-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@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-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNoOHFjODAwMjIscj1pdTdmenRuOG4wMlBJazNsR3Rsaw==</auth>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pdTdmenRuOG4wMlBJazNsR3Rsa01rMEJzbzFpTTgwdEsxV0FCbWptLHM9UWY2R1phaCtOTXc2aEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aXU3Znp0bjhuMDJQSWszbEd0bGtNazBCc28xaU04MHRLMVdBQm1qbSxwPXJTTVJ4QXliV0JtenJlUUoxTmNxMlZURnFuVGpRNmFXWHRtVzBUYm5tdDA9</response>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:33 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:33 | [Mutex] received everything.

2019-10-13 20:44:33 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:33 | [Mutex] waiting for: [event]

2019-10-13 20:44:33 | user :: user_3h8qc80022@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-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@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-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNoOHFjODAwMjIscj15cHh5dGJraHBxZnE5S0txdFVKVA==</auth>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15cHh5dGJraHBxZnE5S0txdFVKVHRRcnVMQWNuS1BrdDZ1WmxUU1RNLHM9UWY2R1phaCtOTXc2aEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eXB4eXRia2hwcWZxOUtLcXRVSlR0UXJ1TEFjbktQa3Q2dVpsVFNUTSxwPXJKbFg2V2xQYy8rY0R0Vkp0U1JnVm5NUng1QUgrZnFPTjV6QTJPTlZ6VWM9</response>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:44:33 | [Mutex] notify: [event, authFailed]

2019-10-13 20:44:33 | [Mutex] received everything.

2019-10-13 20:44:33 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:44:33 | user :: user_3h8qc80022@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-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@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-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNoOHFjODAwMjIscj1rSVo2UG5HRFExUDFYWE5qa3ROcw==</auth>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rSVo2UG5HRFExUDFYWE5qa3ROczVsMWpMZWtGNEJJalAxTXc1RnNlLHM9UWY2R1phaCtOTXc2aEE9PSxpPTQwOTY=</challenge>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a0laNlBuR0RRMVAxWFhOamt0TnM1bDFqTGVrRjRCSWpQMU13NUZzZSxwPWtNYXBpbm54VGZQaVpESXNXT0lLbFg4ZGkxWjVaZ0hHT0YxVHVHeTRzd2M9</response>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ybTd2Z3E1Y3c2WHRycnlrUkkxSzBMNXY1c3R2UkFVS2ZoU1BaT0Q0ZDR3PQ==</success>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c ver="fD1ATDhYhT37hyTvdBFDDag+4EU=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost >> <iq xmlns="jabber:client" id="miJHICFtdGADKDiHNJMQHJU" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost << <iq to="user_3h8qc80022@localhost/993927746-tigase-17" xmlns="jabber:client" type="result" id="miJHICFtdGADKDiHNJMQHJU"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_3h8qc80022@localhost/993927746-tigase-17</jid></bind></iq>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-17 >> <iq xmlns="jabber:client" id="tnW4BGv2bLFEAbHQ9rfEvo2" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-17 << <iq to="user_3h8qc80022@localhost/993927746-tigase-17" xmlns="jabber:client" type="result" id="tnW4BGv2bLFEAbHQ9rfEvo2"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-17 >> <iq to="localhost" id="Os9gBDsbGyxdHEwvu7gDFtg" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-17 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-17 << <enabled resume="true" max="60" xmlns="urn:xmpp:sm:3" location="d4270859fb27" id="590f552b-280b-4978-aa61-825eecf11500"/>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-17 >> <iq id="qAv7vgKXoVSR7n4qR3yzhV0" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-17 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2019-10-13 20:44:33 | Disconnecting

2019-10-13 20:44:33 | user :: user_3h8qc80022@localhost/993927746-tigase-17 << <presence to="user_3h8qc80022@localhost" xmlns="jabber:client" from="user_3h8qc80022@localhost/993927746-tigase-17"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence>

2019-10-13 20:44:33 | [Mutex] notify: [disconnected]

2019-10-13 20:44:33 | [Mutex] received everything.

2019-10-13 20:44:35 | [Mutex] waiting for: [user]

2019-10-13 20:44:35 | [Mutex] received everything.

2019-10-13 20:44:35 | [Mutex] isItemNotified: user:ok:true :: true