Brute Force Prevention

Test duration: 15.289s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.596s
2019-11-22 19:26:32 |

2019-11-22 19:26:32 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 19:26:32 | ------------------------------------

2019-11-22 19:26:32 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7bf6bb64

2019-11-22 19:26:32 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@75314a6a}, 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@710ed014}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@340c4051}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7aefe02f}, 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=Fri Nov 22 19:26:32 PST 2019}}}}

2019-11-22 19:26:32 | [Mutex] waiting for: [registration]

2019-11-22 19:26:32 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5f29702

2019-11-22 19:26:32 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@75314a6a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@710ed014}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@340c4051}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7aefe02f}, 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=Fri Nov 22 19:26:32 PST 2019}}}}

2019-11-22 19:26:32 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2fb69d8

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

2019-11-22 19:26:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5423bf1e}

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

2019-11-22 19:26:32 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:32 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 19:26:32 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@51c8c32d

2019-11-22 19:26:32 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@40130491

2019-11-22 19:26:33 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-22 19:26:33 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19ff00e2}

2019-11-22 19:26:33 | user :: null >> <iq to="localhost" id="lOHMPPGs2czyn3gMKJziAtg" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 19:26:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@322e19d1}

2019-11-22 19:26:33 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@506d878c

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

2019-11-22 19:26:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@47abe707}

2019-11-22 19:26:33 | user :: null >> <iq to="localhost" id="Qryuo3hAgEq1sbFueExbw2n" type="set"><query xmlns="jabber:iq:register"><username>user_awtyyt0027</username><password>user_awtyyt0027</password><email>3df3354a-8ba0-4b67-8189-29cf76e050d1@localhost</email></query></iq>

2019-11-22 19:26:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@aae8d7d4}

2019-11-22 19:26:33 | user :: null << <iq id="Qryuo3hAgEq1sbFueExbw2n" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-22 19:26:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1fc444ef}

2019-11-22 19:26:33 | [Mutex] received everything.

2019-11-22 19:26:33 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 19:26:33 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5423bf1e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19ff00e2]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@75314a6a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@710ed014}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@340c4051}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7aefe02f}, 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=Fri Nov 22 19:26:33 PST 2019}}}}

2019-11-22 19:26:33 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5423bf1e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19ff00e2]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@75314a6a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@710ed014}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@340c4051}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7aefe02f}, 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=Fri Nov 22 19:26:33 PST 2019}}}}

2019-11-22 19:26:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7e5dbfe5

2019-11-22 19:26:33 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@42b01645

2019-11-22 19:26:33 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5abb52cb

2019-11-22 19:26:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@67e5964f

2019-11-22 19:26:33 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@7454afc1

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1KcWVyVjVZbDVnY2prQXdmZkRiNg==</auth>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KcWVyVjVZbDVnY2prQXdmZkRiNjFDOVZHbm51TDkxQ2dKWUNnMG9HLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SnFlclY1WWw1Z2Nqa0F3ZmZEYjYxQzlWR25udUw5MUNnSllDZzBvRyxwPXJUVXVQc1U1T1dnQ0dqQW9JTHJqZXErWUUwMnFLTG02QXNQYU9ZUGNMa3c9</response>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1jR0JpWU5lMlpLYlFpRVBaZ2ZUaFRwRVEycTVEUXB6Z3dTZDJUdGJ1NHFnPQ==</success>

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

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <iq xmlns="jabber:client" id="EJo4iAAy9MN25zaKU5lIwas" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <iq id="EJo4iAAy9MN25zaKU5lIwas" to="user_awtyyt0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_awtyyt0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="KuDIFMzx6CEzjEoUW3wjV0g" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost/993927746-tigase-19 << <iq id="KuDIFMzx6CEzjEoUW3wjV0g" to="user_awtyyt0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result"/>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="mSLLHqW08riR1cEudxesdKE" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost/993927746-tigase-19 << <enabled id="990b3156-3598-4e5d-8330-c0d58be2106d" xmlns="urn:xmpp:sm:3" resume="true" location="d4270859fb27" max="60"/>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost/993927746-tigase-19 >> <iq id="sBUXkV9sawhFuYfOMywqTgL" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost/993927746-tigase-19 << <iq id="mSLLHqW08riR1cEudxesdKE" to="user_awtyyt0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39"/><identity type="im" category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39"/><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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

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

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost/993927746-tigase-19 << <iq id="sBUXkV9sawhFuYfOMywqTgL" to="user_awtyyt0027@localhost/993927746-tigase-19" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:26:33 | Disconnecting

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

2019-11-22 19:26:33 | [Mutex] notify: [disconnected]

2019-11-22 19:26:33 | [Mutex] received everything.

2019-11-22 19:26:33 | [Mutex] waiting for: [event]

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj0xN2cwZVBuZlVRQUl2b3RFOWswUg==</auth>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xN2cwZVBuZlVRQUl2b3RFOWswUmxQemtHcmduVkRFWWYxdUt0MHN5LHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MTdnMGVQbmZVUUFJdm90RTlrMFJsUHprR3JnblZERVlmMXVLdDBzeSxwPVFQU0ZYcnRHOGc1c1hobzNjYUhXNndKZDhPTEFZY0U2eUNlTlVraDRtcWs9</response>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:33 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:33 | [Mutex] received everything.

2019-11-22 19:26:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:33 | [Mutex] waiting for: [event]

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj13Q2dWMmZuc3N2SXdYNWN0TXRtdQ==</auth>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13Q2dWMmZuc3N2SXdYNWN0TXRtdWhIb0J6VnRiNWs3RURlOFdZRFhlLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d0NnVjJmbnNzdkl3WDVjdE10bXVoSG9CelZ0YjVrN0VEZThXWURYZSxwPUtYN3pTTFV1dlVWamwwRkZpMWN3OVhMTERkaWNMUnI2SFpwbFFBUFR3dms9</response>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:33 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:33 | [Mutex] received everything.

2019-11-22 19:26:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:33 | [Mutex] waiting for: [event]

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1uTktBSlE2bENMTDhEcktQYzBjUA==</auth>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uTktBSlE2bENMTDhEcktQYzBjUFhwQmZsRkR4WE1jbU5OTGFjaVBPLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bk5LQUpRNmxDTEw4RHJLUGMwY1BYcEJmbEZEeFhNY21OTkxhY2lQTyxwPUJ5SVl3ejNmdERtUVhPbE9Ma3grT3h6aGFXVUhTYy9BQlowb2dUNTJWZlU9</response>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:33 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:33 | [Mutex] received everything.

2019-11-22 19:26:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:33 | [Mutex] waiting for: [event]

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj00aXZ3UFhNUXNyZE1SQVJBOGR2bQ==</auth>

2019-11-22 19:26:33 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00aXZ3UFhNUXNyZE1SQVJBOGR2bTBuSjE4aHFiMDVKc3l3d2dYb0dGLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NGl2d1BYTVFzcmRNUkFSQThkdm0wbkoxOGhxYjA1SnN5d3dnWG9HRixwPXI2RVJpWE9aWlBCRlREdFNIaVkyQ21POUxaZkpTQW1Md3hIL25TZWxjdGM9</response>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:34 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:34 | [Mutex] received everything.

2019-11-22 19:26:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:34 | [Mutex] waiting for: [event]

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1WWkVhWnhwa1kxQlVqMjRoejFyMQ==</auth>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WWkVhWnhwa1kxQlVqMjRoejFyMXNLQXlEUFhGdk4xV2tzZGhNQXNFLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VlpFYVp4cGtZMUJVajI0aHoxcjFzS0F5RFBYRnZOMVdrc2RoTUFzRSxwPXQ1cm01c1BRd0Q0UkFIcG5wRUtCREpvYXZUN1NLOXc2V2FyUGR5cmJ3SFU9</response>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:34 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:34 | [Mutex] notify: [event, disconnected]

2019-11-22 19:26:34 | [Mutex] received everything.

2019-11-22 19:26:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:34 | [Mutex] waiting for: [event]

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1lNkVDMm53SjI2Uk8yRklEcVdyTg==</auth>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lNkVDMm53SjI2Uk8yRklEcVdyTlNlYTZzRXgybFVEZVZiWHI2azN6LHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZTZFQzJud0oyNlJPMkZJRHFXck5TZWE2c0V4MmxVRGVWYlhyNmszeixwPVBKYlZLbFFtYzNUeCtycTNZMFY2TzN6RThua2p4TEFZWUNmTEo5Y3hEMm89</response>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:34 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:34 | [Mutex] received everything.

2019-11-22 19:26:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:34 | [Mutex] waiting for: [event]

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1SaEFjY21MWVh6ZkdUbDhNVktEVg==</auth>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SaEFjY21MWVh6ZkdUbDhNVktEVnlNU2pVTFZoQzFTSTg1UDJ0U0JYLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UmhBY2NtTFlYemZHVGw4TVZLRFZ5TVNqVUxWaEMxU0k4NVAydFNCWCxwPWl1QzRzeUNQYXFuODgveUl0TEQzVkZwUnRablg1eCtXVkJZWXJyYjVtYmc9</response>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:34 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:34 | [Mutex] received everything.

2019-11-22 19:26:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:34 | [Mutex] waiting for: [event]

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj11ZnIxSlFpZ1FNbTdmQ3R6djFZNg==</auth>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11ZnIxSlFpZ1FNbTdmQ3R6djFZNm13cUZmZHFvVFVCYW1OYUdWWTJyLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWZyMUpRaWdRTW03ZkN0enYxWTZtd3FGZmRxb1RVQmFtTmFHVlkycixwPWtKdFJmTHpRYndqWjMxTERPdFlZZXRnVlgwNDJvazhneXRDSXBOWHFMZm89</response>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:34 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:34 | [Mutex] received everything.

2019-11-22 19:26:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:34 | [Mutex] waiting for: [event]

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1CMEtJRkhpVEc5bGdTRlBPTlJtMA==</auth>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CMEtJRkhpVEc5bGdTRlBPTlJtMENNNE4zSTk1SEViTzlMVTRuS1JaLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QjBLSUZIaVRHOWxnU0ZQT05SbTBDTTROM0k5NUhFYk85TFU0bktSWixwPUVXTGY4SmxWTHJhMW9uaWV2d3pvN0VvaXB2SHlrZWtFMENEamdJRU5NZEU9</response>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:34 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:34 | [Mutex] received everything.

2019-11-22 19:26:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:34 | [Mutex] waiting for: [event]

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj14VzI4V1M0cUY5YUVXWXNvVzZnZw==</auth>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14VzI4V1M0cUY5YUVXWXNvVzZnZ2o3eW9kOUpubTcyTlZGMEdGTUxvLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eFcyOFdTNHFGOWFFV1lzb1c2Z2dqN3lvZDlKbm03Mk5WRjBHRk1MbyxwPWFIYUpROWVkT0FDVCtreG91d1ZRU2FkTTFudEFoc1Vpck5Wb0t2TndFY009</response>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:34 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:34 | [Mutex] received everything.

2019-11-22 19:26:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:34 | [Mutex] waiting for: [event]

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:34 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1YQUsyQnFiUnhHRUJ5QjZSYWh2eA==</auth>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YQUsyQnFiUnhHRUJ5QjZSYWh2eGlGYnZzNkd3MHkwdlE5R3pIbVFFLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WEFLMkJxYlJ4R0VCeUI2UmFodnhpRmJ2czZHdzB5MHZROUd6SG1RRSxwPTh2QW5CQnpzcXF2N1hlMkZhd3lVNDNWRjh4a2paZVMzVGROVnJ0VjZyYzQ9</response>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:35 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:35 | [Mutex] received everything.

2019-11-22 19:26:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:35 | [Mutex] waiting for: [event]

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1LZ1lzZEVBNTVuR2xQTFlwNGp5WA==</auth>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LZ1lzZEVBNTVuR2xQTFlwNGp5WEd2WXZsajRXaGw3NUIwblRlbjJ5LHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S2dZc2RFQTU1bkdsUExZcDRqeVhHdll2bGo0V2hsNzVCMG5UZW4yeSxwPXk3ZnoyV3lVeldFakpIODJRdUpzYkF5ZzN4aUFqczVUTXFnbkRGMDV6Slk9</response>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:35 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:35 | [Mutex] received everything.

2019-11-22 19:26:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:35 | [Mutex] waiting for: [event]

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj13bU01azVrS0tzS1lPWTRBd25mTg==</auth>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13bU01azVrS0tzS1lPWTRBd25mTnY3YkY0aU1PczNTVDZ1ek14Qm1ZLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d21NNWs1a0tLc0tZT1k0QXduZk52N2JGNGlNT3MzU1Q2dXpNeEJtWSxwPXBldXVDRWxzTnJQTmZPMWNQaDM4Y0hCZUd2d084a0tXZnJtb0FqbFVqMVU9</response>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:35 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:35 | [Mutex] received everything.

2019-11-22 19:26:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:35 | [Mutex] waiting for: [event]

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj0yYlhtM2drQnZ4d3IzM3hSTXZRZw==</auth>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yYlhtM2drQnZ4d3IzM3hSTXZRZzBPenZoZzVlUENySmRjVHkzMjZCLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MmJYbTNna0J2eHdyMzN4Uk12UWcwT3p2aGc1ZVBDckpkY1R5MzI2QixwPTBTWWQ2NWtaVnRLbG1rYUVvRjd0dnIvRUxxYjZQUjlXeFdZV3oydFVtdzQ9</response>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:35 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:35 | [Mutex] received everything.

2019-11-22 19:26:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:35 | [Mutex] waiting for: [event]

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1oaExRNzlXVjA4R3FpZk1SQWJpQQ==</auth>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oaExRNzlXVjA4R3FpZk1SQWJpQWQ3NGhVdlhNSmJ1dlo2OWRQZzZHLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aGhMUTc5V1YwOEdxaWZNUkFiaUFkNzRoVXZYTUpidXZaNjlkUGc2RyxwPU1jbzFIVDQwci9jbVNMdmxqVUVseXhVdHJwVitlb1B6eHhIRGJoWjQ4RFE9</response>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:35 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:35 | [Mutex] notify: [event, disconnected]

2019-11-22 19:26:35 | [Mutex] received everything.

2019-11-22 19:26:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:35 | [Mutex] waiting for: [event]

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1nRllubDJGWkpzQ1dzVE0yV2xiNA==</auth>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nRllubDJGWkpzQ1dzVE0yV2xiNGNrMWNZNmNqSXJOaW9MN1NZN0NSLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z0ZZbmwyRlpKc0NXc1RNMldsYjRjazFjWTZjaklyTmlvTDdTWTdDUixwPUlPaTNFRzRreXRCNktGbWhPYTZ0cXNmTzhMOUY5VUNXa0NqazJDL2RpTk09</response>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:35 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:35 | [Mutex] received everything.

2019-11-22 19:26:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:35 | [Mutex] waiting for: [event]

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1lazJoUG9TR1NIRDFwY2VFNEo0TQ==</auth>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lazJoUG9TR1NIRDFwY2VFNEo0TXJTT0RJT1NTTGFwUGlWdThsOHFGLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZWsyaFBvU0dTSEQxcGNlRTRKNE1yU09ESU9TU0xhcFBpVnU4bDhxRixwPVdqaUlReG9SQnFnSk5ubWR2ZjFvTkZnMXd2TTZQYng0YTQzc2h0NUZmQzQ9</response>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:35 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:35 | [Mutex] received everything.

2019-11-22 19:26:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:35 | [Mutex] waiting for: [event]

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1tSDB3SURWRkxpZ1lOM1lWS2d1OQ==</auth>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tSDB3SURWRkxpZ1lOM1lWS2d1OWVjVUVGc1Y0OWtYenp6bW05VE1oLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bUgwd0lEVkZMaWdZTjNZVktndTllY1VFRnNWNDlrWHp6em1tOVRNaCxwPUZROTA2WE9UbjZlVUpiZm5ucWhlTmo0NkF2MFZBWi9KWC85bFRiZlFSVHc9</response>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:35 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:35 | [Mutex] notify: [event, disconnected]

2019-11-22 19:26:35 | [Mutex] received everything.

2019-11-22 19:26:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:35 | [Mutex] waiting for: [event]

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:35 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj10SEJrVXVET2dpYnowY2xYb3pXcQ==</auth>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10SEJrVXVET2dpYnowY2xYb3pXcVpUdGlmVER6aURYT21KUlRwZkIxLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dEhCa1V1RE9naWJ6MGNsWG96V3FaVHRpZlREemlEWE9tSlJUcGZCMSxwPWtDNk9YbHE2Q0I3LzBNOEI1OTdLWW5pTEhCdkIrSmp1b1Uyb0FJcFpqQVU9</response>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:36 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:36 | [Mutex] received everything.

2019-11-22 19:26:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:36 | [Mutex] waiting for: [event]

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1ucExOREVLM0FWYjBPcHNGNjNaZg==</auth>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ucExOREVLM0FWYjBPcHNGNjNaZnFKWVZPRWVRQm9yaExNdjNscHc5LHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bnBMTkRFSzNBVmIwT3BzRjYzWmZxSllWT0VlUUJvcmhMTXYzbHB3OSxwPWVSblNwWnplUHhpamUwY0pQTTlHZ1k4bU02N1VZbFFhdTVXQUFvQmVRVWM9</response>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:36 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:36 | [Mutex] received everything.

2019-11-22 19:26:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:36 | [Mutex] waiting for: [event]

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1JakN0M3d0cFlScXYxNDZXeGlNSQ==</auth>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JakN0M3d0cFlScXYxNDZXeGlNSWxGdE9ZZUpia0dxSWFibnpNOXNSLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SWpDdDN3dHBZUnF2MTQ2V3hpTUlsRnRPWWVKYmtHcUlhYm56TTlzUixwPTdPTjhiNDdCNkNCTVlwc0h3K0hXQXpmcFUxd1JLQmNXOGdwMFJraFViQ2s9</response>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:36 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:36 | [Mutex] received everything.

2019-11-22 19:26:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2F3dHl5dDAwMjcscj1RcDlHVFRreXNjbHR3ZkJ2aUkwUQ==</auth>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RcDlHVFRreXNjbHR3ZkJ2aUkwUU5teFN6UmJXMW5wU3hNaHNGS2FCLHM9UU1JTnRkbGVjdHVtZlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UXA5R1RUa3lzY2x0d2ZCdmlJMFFObXhTelJiVzFucFN4TWhzRkthQixwPXhYdGdQVitFZnFicWhKcmlkOWsvMzR2ZndrcUVZaWRyYldyQWxKWFo1SWM9</response>

2019-11-22 19:26:36 | user :: user_awtyyt0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: user_awtyyt0027@localhost is not authorized to act as user_awtyyt0027@localhost</text></failure>

2019-11-22 19:26:38 | [Mutex] waiting for: [user]

2019-11-22 19:26:38 | [Mutex] received everything.

2019-11-22 19:26:38 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.215s
2019-11-22 19:26:38 |

2019-11-22 19:26:38 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 19:26:38 | ------------------------------------

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6da82b5

2019-11-22 19:26:38 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@81d6c1e}, 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@c22e9c5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@49206625}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1bbd8a9e}, 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=Fri Nov 22 19:26:38 PST 2019}}}}

2019-11-22 19:26:38 | [Mutex] waiting for: [registration]

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7823686b

2019-11-22 19:26:38 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@81d6c1e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@c22e9c5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@49206625}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1bbd8a9e}, 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=Fri Nov 22 19:26:38 PST 2019}}}}

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@6354da6b

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

2019-11-22 19:26:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@290f996a}

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

2019-11-22 19:26:38 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5e111faf

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3d924436

2019-11-22 19:26:38 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7850566d}

2019-11-22 19:26:38 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-22 19:26:38 | user :: null >> <iq to="localhost" id="uWPT5kU0fBmIJMIqgURcDIr" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 19:26:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@888e4634}

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

2019-11-22 19:26:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2d4144c4}

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@7b7bcaa4

2019-11-22 19:26:38 | user :: null >> <iq to="localhost" id="ZI7CvjMOORPOCxoWSaItq5C" type="set"><query xmlns="jabber:iq:register"><username>user_pknf200028</username><password>user_pknf200028</password><email>1cadfdfe-42fb-4078-af6d-5ac1498fb759@localhost</email></query></iq>

2019-11-22 19:26:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@99480a16}

2019-11-22 19:26:38 | user :: null << <iq id="ZI7CvjMOORPOCxoWSaItq5C" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-22 19:26:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@54e79209}

2019-11-22 19:26:38 | [Mutex] received everything.

2019-11-22 19:26:38 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 19:26:38 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@290f996a, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7850566d]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@81d6c1e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@c22e9c5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@49206625}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1bbd8a9e}, 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=Fri Nov 22 19:26:38 PST 2019}}}}

2019-11-22 19:26:38 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@290f996a, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7850566d]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@81d6c1e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@c22e9c5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@49206625}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1bbd8a9e}, 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=Fri Nov 22 19:26:38 PST 2019}}}}

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2e7e55c6

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@93e43a9

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2c3596c0

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@44aa2e95

2019-11-22 19:26:38 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@182693a3

2019-11-22 19:26:38 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:38 | user :: user_pknf200028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:38 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:38 | user :: user_pknf200028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BrbmYyMDAwMjgscj1TVUxhRG1pRFBHTjcxUGlhd2xKSA==</auth>

2019-11-22 19:26:38 | user :: user_pknf200028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TVUxhRG1pRFBHTjcxUGlhd2xKSFZOUmk2aDVRVGhJY1hlNGRzR2JPLHM9ZVhvQTlKdUQxSlVaUWc9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:38 | user :: user_pknf200028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U1VMYURtaURQR043MVBpYXdsSkhWTlJpNmg1UVRoSWNYZTRkc0diTyxwPW1FRkZxeWFPOHNjeGdJVjFZL0NNSWErNXNvaDlUN2NmWmdGSmxBOHpYaG89</response>

2019-11-22 19:26:38 | user :: user_pknf200028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1SNTMzS28rWStYWjhFSkY0U1ZScDZRN2cxV1BGa1FYQXdXWm94cGNPa25vPQ==</success>

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

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <iq xmlns="jabber:client" id="5FW00jW24yu1wh01rUeS1ds" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <iq id="5FW00jW24yu1wh01rUeS1ds" to="user_pknf200028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_pknf200028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="mZSZ9kKCmTcFDq6o19sU7yg" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost/993927746-tigase-20 << <iq id="mZSZ9kKCmTcFDq6o19sU7yg" to="user_pknf200028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result"/>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost/993927746-tigase-20 >> <iq to="localhost" id="iBGJuocFv2as2fU5t6s6rZ8" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost/993927746-tigase-20 << <enabled id="884bae7c-746d-4ac4-a357-c3a98369368c" xmlns="urn:xmpp:sm:3" resume="true" location="d4270859fb27" max="60"/>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost/993927746-tigase-20 >> <iq id="BIZ6cHIAaKSN4ncpdsk4pZ0" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost/993927746-tigase-20 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost/993927746-tigase-20 << <iq id="iBGJuocFv2as2fU5t6s6rZ8" to="user_pknf200028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39"/><identity type="im" category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39"/><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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost/993927746-tigase-20 << <iq id="BIZ6cHIAaKSN4ncpdsk4pZ0" to="user_pknf200028@localhost/993927746-tigase-20" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:26:39 | Disconnecting

2019-11-22 19:26:39 | user :: user_pknf200028@localhost/993927746-tigase-20 << <presence to="user_pknf200028@localhost" xmlns="jabber:client" from="user_pknf200028@localhost/993927746-tigase-20"><c node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 19:26:39 | [Mutex] notify: [disconnected]

2019-11-22 19:26:39 | [Mutex] received everything.

2019-11-22 19:26:39 | [Mutex] waiting for: [event]

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BrbmYyMDAwMjgscj1EUFhRUW5VNkRSVXRVeDlyWGR3aw==</auth>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EUFhRUW5VNkRSVXRVeDlyWGR3a25YME4wOWJLUElwRTNlMmI1WUFsLHM9ZVhvQTlKdUQxSlVaUWc9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RFBYUVFuVTZEUlV0VXg5clhkd2tuWDBOMDliS1BJcEUzZTJiNVlBbCxwPWExK0w2R29rZy90RHcxWWtFRE9EY251clFyT0VVU0x4MGZEOFhhRHg5eXM9</response>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:39 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:39 | [Mutex] received everything.

2019-11-22 19:26:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:39 | [Mutex] waiting for: [event]

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BrbmYyMDAwMjgscj1QaDZCdVF2SnRubHJqMWJnaVloZg==</auth>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QaDZCdVF2SnRubHJqMWJnaVloZkdZWXduemF2RDd2Z2ptR041dkFRLHM9ZVhvQTlKdUQxSlVaUWc9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UGg2QnVRdkp0bmxyajFiZ2lZaGZHWVl3bnphdkQ3dmdqbUdONXZBUSxwPWpyOFU1eWsvWmJrMGxFMnp2VEJ2YTZ2RGVFR3NjeGdrOE9KZUpQRytkNnc9</response>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:39 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:39 | [Mutex] received everything.

2019-11-22 19:26:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:39 | [Mutex] waiting for: [event]

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BrbmYyMDAwMjgscj1iUEV6dEhJMWxuS1JaSmRyTnNHVA==</auth>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iUEV6dEhJMWxuS1JaSmRyTnNHVGdLcEdiOFJ2NHdtMnVEUm9LT0VxLHM9ZVhvQTlKdUQxSlVaUWc9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YlBFenRISTFsbktSWkpkck5zR1RnS3BHYjhSdjR3bTJ1RFJvS09FcSxwPWFXTkNxMkJQRlNlak5LeTV6ODhVSDdlZ1NpTi9iRGlQQUQveDV3YTJ6TnM9</response>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:39 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:39 | [Mutex] received everything.

2019-11-22 19:26:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:39 | [Mutex] waiting for: [event]

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BrbmYyMDAwMjgscj1haXVPa0FmYXRSMzhIdnFVYmJvZA==</auth>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1haXVPa0FmYXRSMzhIdnFVYmJvZFZPbG1XRG1hUDYwc2tnaWVra2VJLHM9ZVhvQTlKdUQxSlVaUWc9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YWl1T2tBZmF0UjM4SHZxVWJib2RWT2xtV0RtYVA2MHNrZ2lla2tlSSxwPStEcG8ybUJjNDFmU3VQcklyNVpPSWJEbU1TdUVTNTdBL1RFSDRNNmhhalU9</response>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:39 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:39 | [Mutex] received everything.

2019-11-22 19:26:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BrbmYyMDAwMjgscj1uN2k3ZWtzakpuazhUajUzQ0xraA==</auth>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uN2k3ZWtzakpuazhUajUzQ0xraHFqcGFVcEdTM1Q1OFV1NkFnOTdoLHM9ZVhvQTlKdUQxSlVaUWc9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bjdpN2Vrc2pKbms4VGo1M0NMa2hxanBhVXBHUzNUNThVdTZBZzk3aCxwPXVsb0RGQlRMN0hLODB3aFNyd0xkOXU2YWsvd3Z1eERWZFcxUU9KSHRUS0E9</response>

2019-11-22 19:26:39 | user :: user_pknf200028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:41 | [Mutex] waiting for: [user]

2019-11-22 19:26:41 | [Mutex] received everything.

2019-11-22 19:26:41 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.025s
2019-11-22 19:26:41 |

2019-11-22 19:26:41 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 19:26:41 | ------------------------------------

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@689a681e

2019-11-22 19:26:41 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@665d8b7d}, 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@6262036e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@27608146}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c81c72c}, 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=Fri Nov 22 19:26:41 PST 2019}}}}

2019-11-22 19:26:41 | [Mutex] waiting for: [registration]

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@160da1a2

2019-11-22 19:26:41 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@665d8b7d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@6262036e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@27608146}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c81c72c}, 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=Fri Nov 22 19:26:41 PST 2019}}}}

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@6406b97e

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

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

2019-11-22 19:26:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@474f7e09}

2019-11-22 19:26:41 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@55e5796b

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2e1ed2c4

2019-11-22 19:26:41 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f025330}

2019-11-22 19:26:41 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-22 19:26:41 | user :: null >> <iq to="localhost" id="0XCmY8v7oMR2esk27IFMzx6" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 19:26:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8a4826e}

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

2019-11-22 19:26:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4301c5ef}

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3dd1c2c5

2019-11-22 19:26:41 | user :: null >> <iq to="localhost" id="ZQfS1lQW4nRSKNUYWiYZs9K" type="set"><query xmlns="jabber:iq:register"><username>user_fdfgca0029</username><password>user_fdfgca0029</password><email>5b24cbcf-653a-427a-bd0a-f1f09711c871@localhost</email></query></iq>

2019-11-22 19:26:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@9501ba74}

2019-11-22 19:26:41 | user :: null << <iq id="ZQfS1lQW4nRSKNUYWiYZs9K" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-22 19:26:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6581af49}

2019-11-22 19:26:41 | [Mutex] received everything.

2019-11-22 19:26:41 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 19:26:41 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@474f7e09, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f025330]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@665d8b7d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@6262036e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@27608146}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c81c72c}, 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=Fri Nov 22 19:26:41 PST 2019}}}}

2019-11-22 19:26:41 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@474f7e09, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7f025330]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@665d8b7d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@6262036e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@27608146}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1c81c72c}, 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=Fri Nov 22 19:26:41 PST 2019}}}}

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@8f7eb1a

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@45946956

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@76605ccb

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1ef35ea9

2019-11-22 19:26:41 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@296bd956

2019-11-22 19:26:41 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:41 | user :: user_fdfgca0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2ZkZmdjYTAwMjkscj15NjRjWXpXSXhGcUIwVHJseTBNcw==</auth>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15NjRjWXpXSXhGcUIwVHJseTBNczB2cU96QTlRem56ckM1UHF5bGdkLHM9Z3ZSSWxoV1ltTUp2Z1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eTY0Y1l6V0l4RnFCMFRybHkwTXMwdnFPekE5UXpuenJDNVBxeWxnZCxwPSttRTRLM0tQYWFYUmVrSGU2WDNaZzhIOHN6NmNnL1VJMWVYT2c0QUZ6NmM9</response>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1MK0E1cW5KOW5uSjVlUTArNEdwdXdreU5la2paUHhZTTNxVHp4YTFIV0RFPQ==</success>

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

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <iq xmlns="jabber:client" id="F0Hw2umL0fWTbocOTXWY4gH" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <iq id="F0Hw2umL0fWTbocOTXWY4gH" to="user_fdfgca0029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_fdfgca0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="nYzhAgEq1sbFueExbw2n4iA" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost/993927746-tigase-21 << <iq id="nYzhAgEq1sbFueExbw2n4iA" to="user_fdfgca0029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result"/>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="R81q7pQMGu9IHHymU3dAaDA" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost/993927746-tigase-21 << <enabled id="2fd7cb8b-b520-4ba0-8a28-ba9e3b39347d" xmlns="urn:xmpp:sm:3" resume="true" location="d4270859fb27" max="60"/>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost/993927746-tigase-21 >> <iq id="2ZygLDqQZiKuoaneHQHNCEI" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost/993927746-tigase-21 << <iq id="R81q7pQMGu9IHHymU3dAaDA" to="user_fdfgca0029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39"/><identity type="im" category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39"/><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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost/993927746-tigase-21 << <iq id="2ZygLDqQZiKuoaneHQHNCEI" to="user_fdfgca0029@localhost/993927746-tigase-21" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:26:42 | Disconnecting

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

2019-11-22 19:26:42 | [Mutex] notify: [disconnected]

2019-11-22 19:26:42 | [Mutex] received everything.

2019-11-22 19:26:42 | [Mutex] waiting for: [event]

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2ZkZmdjYTAwMjkscj1nZnM5dzJhbW5pZ2paYU1kaDFlUw==</auth>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nZnM5dzJhbW5pZ2paYU1kaDFlU2d4UjAza0dZSmZNOHJ6ck9sUFlSLHM9Z3ZSSWxoV1ltTUp2Z1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z2ZzOXcyYW1uaWdqWmFNZGgxZVNneFIwM2tHWUpmTThyenJPbFBZUixwPXJEem5mRStDZEQ4SWhXYWNiT2cvUTRGK3NraEhzaWtFQVdTQ01oOTk0VG89</response>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:42 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:42 | [Mutex] received everything.

2019-11-22 19:26:42 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:42 | [Mutex] waiting for: [event]

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2ZkZmdjYTAwMjkscj1yZ3pJUW9qUTk0d3hBV3lBczR5Uw==</auth>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yZ3pJUW9qUTk0d3hBV3lBczR5UzhOQjhaUE10RHl0TThkbTltM29CLHM9Z3ZSSWxoV1ltTUp2Z1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cmd6SVFvalE5NHd4QVd5QXM0eVM4TkI4WlBNdER5dE04ZG05bTNvQixwPURLUXlIMGtXQ1VzQzkzK3gwUVAwMlhVMEFRNXFqVHFZOGNsNGlyRFE5TkE9</response>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:42 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:42 | [Mutex] received everything.

2019-11-22 19:26:42 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:42 | [Mutex] waiting for: [event]

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2ZkZmdjYTAwMjkscj1HbWZSZnRhcnlkaUdXZXBXVzdSRw==</auth>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HbWZSZnRhcnlkaUdXZXBXVzdSR1BBdFREb3ZRT1JXNmlUOUNtYzloLHM9NHh4RnJtOEFVMEhyQ1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R21mUmZ0YXJ5ZGlHV2VwV1c3UkdQQXRURG92UU9SVzZpVDlDbWM5aCxwPU1zR2NYTHZ0NFFTa2x0TkErTEZ6NVg3R2M2bz0=</response>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:42 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:42 | [Mutex] received everything.

2019-11-22 19:26:42 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:42 | [Mutex] waiting for: [event]

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2ZkZmdjYTAwMjkscj0yNGU2akpVQzNTQ3pVNkhlWnRORw==</auth>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yNGU2akpVQzNTQ3pVNkhlWnROR2U2Y1lSeFlwUWo5R3hhd2J6bHpNLHM9NHh4RnJtOEFVMEhyQ1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MjRlNmpKVUMzU0N6VTZIZVp0TkdlNmNZUnhZcFFqOUd4YXdiemx6TSxwPWVRdVlHQVFCdThBdndTN3ZVZTM4TlpyODZBaz0=</response>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:42 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:42 | [Mutex] received everything.

2019-11-22 19:26:42 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2ZkZmdjYTAwMjkscj0xSWpoWmw0T3dhN3Nrc0dPSnhhUA==</auth>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xSWpoWmw0T3dhN3Nrc0dPSnhhUGpwVVM5RUxXc3B5VnZOQkdVYlRQLHM9Z3ZSSWxoV1ltTUp2Z1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MUlqaFpsNE93YTdza3NHT0p4YVBqcFVTOUVMV3NweVZ2TkJHVWJUUCxwPVV3MWpqclZObUtuSGhPSXE4eld4QWpuVmxUVURrMytlTkY5V2o0VlpwWUE9</response>

2019-11-22 19:26:42 | user :: user_fdfgca0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:44 | [Mutex] waiting for: [user]

2019-11-22 19:26:44 | [Mutex] received everything.

2019-11-22 19:26:44 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.114s
2019-11-22 19:26:44 |

2019-11-22 19:26:44 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 19:26:44 | ------------------------------------

2019-11-22 19:26:44 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@25161bf3

2019-11-22 19:26:44 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2bd1e121}, 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@2fee7083}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6aeceb1a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7fb0bc37}, 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=Fri Nov 22 19:26:44 PST 2019}}}}

2019-11-22 19:26:44 | [Mutex] waiting for: [registration]

2019-11-22 19:26:44 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5b4c8209

2019-11-22 19:26:44 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2bd1e121}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@2fee7083}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6aeceb1a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7fb0bc37}, 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=Fri Nov 22 19:26:44 PST 2019}}}}

2019-11-22 19:26:44 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@7fa8b8b

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

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

2019-11-22 19:26:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@ac31455}

2019-11-22 19:26:44 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:44 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 19:26:44 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7068403e

2019-11-22 19:26:44 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@4f0bc8f0

2019-11-22 19:26:44 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1cfea449}

2019-11-22 19:26:44 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-22 19:26:44 | user :: null >> <iq to="localhost" id="QOVeS1ds08oXkV9sawhFuYf" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 19:26:44 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2014a42a}

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

2019-11-22 19:26:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e8d6a3f}

2019-11-22 19:26:44 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3c56a260

2019-11-22 19:26:44 | user :: null >> <iq to="localhost" id="F7OKuoaneHQHNCEIHzaqY4j" type="set"><query xmlns="jabber:iq:register"><username>user_b7g59o0030</username><password>user_b7g59o0030</password><email>b9efdb85-a42b-432f-b754-af7abbcda777@localhost</email></query></iq>

2019-11-22 19:26:44 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6df640bb}

2019-11-22 19:26:45 | user :: null << <iq id="F7OKuoaneHQHNCEIHzaqY4j" xmlns="jabber:client" type="result" from="localhost"/>

2019-11-22 19:26:45 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2d8ba152}

2019-11-22 19:26:45 | [Mutex] received everything.

2019-11-22 19:26:45 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 19:26:45 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@ac31455, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1cfea449]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2bd1e121}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@2fee7083}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6aeceb1a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7fb0bc37}, 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=Fri Nov 22 19:26:45 PST 2019}}}}

2019-11-22 19:26:45 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2829d7ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@ac31455, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1cfea449]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2bd1e121}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6914dd81}, 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@2fee7083}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6aeceb1a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7fb0bc37}, 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=Fri Nov 22 19:26:45 PST 2019}}}}

2019-11-22 19:26:45 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@443e8446

2019-11-22 19:26:45 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2107d26c

2019-11-22 19:26:45 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@28cb318e

2019-11-22 19:26:45 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@58ba94f4

2019-11-22 19:26:45 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@68963711

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2I3ZzU5bzAwMzAscj1OeTUwb25YZWJ6VHRZOWJKTDVQeQ==</auth>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OeTUwb25YZWJ6VHRZOWJKTDVQeUg4dUlvUG5LM3IzSjVPc3E2QkNSLHM9OXIrcUVzVXhLWWdVU1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Tnk1MG9uWGVielR0WTliSkw1UHlIOHVJb1BuSzNyM0o1T3NxNkJDUixwPWg5OUFMNTlhUXBlYzNvQTlHQ09nSWFPWE5HTko2cTNZYWxJTVg4TVQ3aFk9</response>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1IYWVtZHQ3aElFT2pBQks0TXN4YUxQcHZ2ejRMN0MrWWlOajEweFlnbGw0PQ==</success>

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

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <iq xmlns="jabber:client" id="ce7AdU3y7Di0q7pQMGu9IHH" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <iq id="ce7AdU3y7Di0q7pQMGu9IHH" to="user_b7g59o0030@localhost/993927746-tigase-22" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_b7g59o0030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="99QOCEGpiP6dPGMYdBeyeAl" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-22 << <iq id="99QOCEGpiP6dPGMYdBeyeAl" to="user_b7g59o0030@localhost/993927746-tigase-22" xmlns="jabber:client" type="result"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="rYhEtmZhIGylNKuhSUO2sXo" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-22 << <enabled id="8c5ae8ed-440d-4c73-9541-9d3339555fbf" xmlns="urn:xmpp:sm:3" resume="true" location="d4270859fb27" max="60"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-22 >> <iq id="FbSSKUcrmXmJRKUeJDiGu6n" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-22 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-22 << <iq id="rYhEtmZhIGylNKuhSUO2sXo" to="user_b7g59o0030@localhost/993927746-tigase-22" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39"/><identity type="im" category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39"/><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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-22 << <iq id="FbSSKUcrmXmJRKUeJDiGu6n" to="user_b7g59o0030@localhost/993927746-tigase-22" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:26:45 | Disconnecting

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-22 << <presence to="user_b7g59o0030@localhost" xmlns="jabber:client" from="user_b7g59o0030@localhost/993927746-tigase-22"><c node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 19:26:45 | [Mutex] notify: [disconnected]

2019-11-22 19:26:45 | [Mutex] received everything.

2019-11-22 19:26:45 | [Mutex] waiting for: [event]

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2I3ZzU5bzAwMzAscj1aN1oyM2djQzA3U0tNQmhpZlRvYw==</auth>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aN1oyM2djQzA3U0tNQmhpZlRvY2ZXampTYUc0YzlXUExKdFkyZnhQLHM9OXIrcUVzVXhLWWdVU1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WjdaMjNnY0MwN1NLTUJoaWZUb2NmV2pqU2FHNGM5V1BMSnRZMmZ4UCxwPUNVN0dzRGJQeks1TDA3L0oweWc1QS9wVG1EcG1UTmNOeU9Ua0tIWW1SSGc9</response>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:45 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:45 | [Mutex] received everything.

2019-11-22 19:26:45 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:45 | [Mutex] waiting for: [event]

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2I3ZzU5bzAwMzAscj1rN2h0N3hmaWY2WVJmSmJXem1JeA==</auth>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rN2h0N3hmaWY2WVJmSmJXem1JeFgyU1hiNlNkVWZqWkFrRExDaDVSLHM9OXIrcUVzVXhLWWdVU1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9azdodDd4ZmlmNllSZkpiV3ptSXhYMlNYYjZTZFVmalpBa0RMQ2g1UixwPTZ0ejMzRUlpRXNXQlc5OGZLZk5lMjY5MGFBZWRCY2lFWTlVL2xvTVdyYkk9</response>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:45 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:45 | [Mutex] received everything.

2019-11-22 19:26:45 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:45 | [Mutex] waiting for: [event]

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2I3ZzU5bzAwMzAscj16Q0RSaERPdHlDQjB5UFdjVEw4SQ==</auth>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16Q0RSaERPdHlDQjB5UFdjVEw4SXdoN0dhTThDU1M0MkVvMEo1TVE3LHM9OXIrcUVzVXhLWWdVU1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ekNEUmhET3R5Q0IweVBXY1RMOEl3aDdHYU04Q1NTNDJFbzBKNU1RNyxwPXV5dnNkd1YrNVJSRk5JeXM0a25mU3I5UlgyVTRPR25UVHovMUxDNzJhKzg9</response>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 19:26:45 | [Mutex] notify: [event, authFailed]

2019-11-22 19:26:45 | [Mutex] received everything.

2019-11-22 19:26:45 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2I3ZzU5bzAwMzAscj1Uc2xJYU1OaTlBcEppamNDaWlHMg==</auth>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Uc2xJYU1OaTlBcEppamNDaWlHMnFpS2ZRQ3pRT0hzUXlvUWpkYlhRLHM9OXIrcUVzVXhLWWdVU1E9PSxpPTQwOTY=</challenge>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VHNsSWFNTmk5QXBKaWpjQ2lpRzJxaUtmUUN6UU9Ic1F5b1FqZGJYUSxwPU15VDJXS215Z0I1dnJmK3QzWW94UkVtVnNiM0lyTUdPZVI1aXFmaGIzQUk9</response>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1nT3JWalpqNk1YZW5YeVNnSUE2NjZ6ZDNJMjBMM0NnaVQwR1lKalJlMHIwPQ==</success>

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

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost >> <iq xmlns="jabber:client" id="Y0jLW9BmY8v7oMR2esk27IF" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost << <iq id="Y0jLW9BmY8v7oMR2esk27IF" to="user_b7g59o0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_b7g59o0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="ji9i0q7pQMGu9IHHymU3dAa" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-23 << <iq id="ji9i0q7pQMGu9IHHymU3dAa" to="user_b7g59o0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="51iIq9CoMYkHSZqR7gWiRTO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-23 << <enabled id="5e49a2e1-d986-4cbf-b0ca-010c56243bde" xmlns="urn:xmpp:sm:3" resume="true" location="d4270859fb27" max="60"/>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-23 >> <iq id="QX4wsbx6iIyhYdJCuazfEiT" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-23 << <iq id="51iIq9CoMYkHSZqR7gWiRTO" to="user_b7g59o0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39"/><identity type="im" category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39"/><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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-23 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-23 << <iq id="QX4wsbx6iIyhYdJCuazfEiT" to="user_b7g59o0030@localhost/993927746-tigase-23" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:26:45 | Disconnecting

2019-11-22 19:26:45 | user :: user_b7g59o0030@localhost/993927746-tigase-23 << <presence to="user_b7g59o0030@localhost" xmlns="jabber:client" from="user_b7g59o0030@localhost/993927746-tigase-23"><c node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 19:26:45 | [Mutex] notify: [disconnected]

2019-11-22 19:26:45 | [Mutex] received everything.

2019-11-22 19:26:47 | [Mutex] waiting for: [user]

2019-11-22 19:26:47 | [Mutex] received everything.

2019-11-22 19:26:47 | [Mutex] isItemNotified: user:ok:true :: true