Brute Force Prevention

2019-11-22 18:56:02 |

2019-11-22 18:56:02 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 18:56:02 | ------------------------------------

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@392f9bad

2019-11-22 18:56:02 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37e862f8}, 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@33d7f0dd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76d568c3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@33627747}, 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 18:56:02 PST 2019}}}}

2019-11-22 18:56:02 | [Mutex] waiting for: [registration]

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@47693c71

2019-11-22 18:56:02 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37e862f8}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@33d7f0dd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76d568c3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@33627747}, 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 18:56:02 PST 2019}}}}

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@4b347d59

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

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

2019-11-22 18:56:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@16fa978c}

2019-11-22 18:56:02 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:56:02 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3682025b

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@38062a4e

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

2019-11-22 18:56:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@503056a2}

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

2019-11-22 18:56:02 | user :: null >> <iq to="localhost" id="lB4o9rVbzgBdELzj1rmThZ6" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 18:56:02 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f57d0bc8}

2019-11-22 18:56:02 | user :: null << <iq id="lB4o9rVbzgBdELzj1rmThZ6" type="result" from="localhost" xmlns="jabber:client"><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 18:56:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@12b4eddf}

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3482b508

2019-11-22 18:56:02 | user :: null >> <iq to="localhost" id="EQLCDoNBxpcQ1s9viX39Dt4" type="set"><query xmlns="jabber:iq:register"><username>user_9o8vri0027</username><password>user_9o8vri0027</password><email>8c9bc6ac-ac72-44f8-ac80-c74a40a2a521@localhost</email></query></iq>

2019-11-22 18:56:02 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@dbdbef75}

2019-11-22 18:56:02 | user :: null << <iq id="EQLCDoNBxpcQ1s9viX39Dt4" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-22 18:56:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3d5fbd8c}

2019-11-22 18:56:02 | [Mutex] received everything.

2019-11-22 18:56:02 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 18:56:02 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@16fa978c, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@503056a2]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37e862f8}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@33d7f0dd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76d568c3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@33627747}, 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 18:56:02 PST 2019}}}}

2019-11-22 18:56:02 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@16fa978c, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@503056a2]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37e862f8}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@33d7f0dd}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76d568c3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@33627747}, 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 18:56:02 PST 2019}}}}

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6f0869c3

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@5ae7abe8

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7bec7f49

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3b1f1e65

2019-11-22 18:56:02 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@17752eb4

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

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj16ZEZwRGhGZjJrdW9mdjJaRnFraQ==</auth>

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16ZEZwRGhGZjJrdW9mdjJaRnFraXpRZ2Jqc0M2WjZkU0JrVkV1Yk43LHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9emRGcERoRmYya3VvZnYyWkZxa2l6UWdianNDNlo2ZFNCa1ZFdWJONyxwPVFyUHZvenV6N2lsL1ZKS2VZQ2dxM2xkcHJNMS9KNm5UUkxqQWwzd0RObjg9</response>

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1lamYxN3NLck0yRHlEMFRVcUpCZnRjZm8rSHVJRTlRbVFaSnROK2d6NjYwPQ==</success>

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

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost >> <iq xmlns="jabber:client" id="FyR5iBdLR6EDGBp6zhBxhGr" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost << <iq id="FyR5iBdLR6EDGBp6zhBxhGr" type="result" to="user_9o8vri0027@localhost/993927746-tigase-19" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_9o8vri0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="KMvj0sfU3jUbv3r5iFlUhBn" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost/993927746-tigase-19 << <iq id="KMvj0sfU3jUbv3r5iFlUhBn" type="result" to="user_9o8vri0027@localhost/993927746-tigase-19" xmlns="jabber:client"/>

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="DX0pWhGnLR3uqbMNNS7nNV3" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost/993927746-tigase-19 << <enabled id="fe2084e4-94ed-49e7-aea4-0a5ae4ba49e9" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/>

2019-11-22 18:56:02 | user :: user_9o8vri0027@localhost/993927746-tigase-19 >> <iq id="wWVRTbL0bR9qfCfvl1qiVgL" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 18:56:02 | Disconnecting

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

2019-11-22 18:56:03 | [Mutex] notify: [disconnected]

2019-11-22 18:56:03 | [Mutex] received everything.

2019-11-22 18:56:03 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1JS1FvV1dPSUR1SW9rbjhCTldRRQ==</auth>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JS1FvV1dPSUR1SW9rbjhCTldRRUtJTUk2a1pRQUN3dTNtWXNCZEd3LHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SUtRb1dXT0lEdUlva244Qk5XUUVLSU1JNmtaUUFDd3UzbVlzQmRHdyxwPWx4S3U1YmFYdmtNcCtUVEt2b1FVUE1Rc1EybnF3N21RUEwrUm5tSEZBUE09</response>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:03 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:03 | [Mutex] received everything.

2019-11-22 18:56:03 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:03 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1JS3RaQkFUbkNkaTBQSTd1UDNrSA==</auth>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JS3RaQkFUbkNkaTBQSTd1UDNrSDkxNmRHZUxsNHQ2S1RLYWRDZXVkLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SUt0WkJBVG5DZGkwUEk3dVAza0g5MTZkR2VMbDR0NktUS2FkQ2V1ZCxwPWRHTW1oZ3E0eExLbnpOWG5EQlAwWU94ODV5WXFxY2lDR3ViM1FCckZBVWs9</response>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:03 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:03 | [Mutex] notify: [event, disconnected]

2019-11-22 18:56:03 | [Mutex] received everything.

2019-11-22 18:56:03 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:03 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj03Q1YwRXBMa05OcG9sV0kyQzR5cA==</auth>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03Q1YwRXBMa05OcG9sV0kyQzR5cG9WcHhvSHhwWFlCUkM5cjdQcTFZLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N0NWMEVwTGtOTnBvbFdJMkM0eXBvVnB4b0h4cFhZQlJDOXI3UHExWSxwPVFUaTVCNmdGbFEvbUNUbGcxdUZoTjlZWTlSVk5GdjFDdVJlTGk3U2dqQms9</response>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:03 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:03 | [Mutex] received everything.

2019-11-22 18:56:03 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:03 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1WaTdDVEJWbUV0c0dzWFlEbVZmOA==</auth>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WaTdDVEJWbUV0c0dzWFlEbVZmOG05V2RBQnBUdERzR0pqU2pDMVBLLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Vmk3Q1RCVm1FdHNHc1hZRG1WZjhtOVdkQUJwVHREc0dKalNqQzFQSyxwPSs3ejlSTjJlYzFlN1JZUGduMzErZkxyYjRaTW1rNVBvcjYxdGpLZkZKYXM9</response>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:03 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:03 | [Mutex] received everything.

2019-11-22 18:56:03 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:03 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1VdGVUcmR0WUFScTdidHBXQ3h0bw==</auth>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VdGVUcmR0WUFScTdidHBXQ3h0b0twb0E3bnU4Z3ByT2tTeDM0aHl6LHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VXRlVHJkdFlBUnE3YnRwV0N4dG9LcG9BN251OGdwck9rU3gzNGh5eixwPWk1WVYvQnZOTStmcXlpNkJtNHhnTHVoTkxVeWg3S3BETmp4V2szd1VBMUE9</response>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:03 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:03 | [Mutex] received everything.

2019-11-22 18:56:03 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:03 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1UWGxkRWFDM3NyMXJKMEhROENwag==</auth>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UWGxkRWFDM3NyMXJKMEhROENwamJOb0ZRa3FzS3phSWFmNlpzeXNULHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VFhsZEVhQzNzcjFySjBIUThDcGpiTm9GUWtxc0t6YUlhZjZac3lzVCxwPXd3YWNoN1creCtpMTgrNklDNU1pV3E4cCs1K1p1c1dBVHVYVklTTFViOG89</response>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:03 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:03 | [Mutex] notify: [event, disconnected]

2019-11-22 18:56:03 | [Mutex] received everything.

2019-11-22 18:56:03 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:03 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj00YzlZTHB1U1Z1aDdZQlBTcTVEeg==</auth>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00YzlZTHB1U1Z1aDdZQlBTcTVEelVnckdWRmp3SFhIa2JnVHlPWm5DLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NGM5WUxwdVNWdWg3WUJQU3E1RHpVZ3JHVkZqd0hYSGtiZ1R5T1puQyxwPVBFZG5HSWg2V1hhckZjQ3o2aWp3RTZ2QVJjVXV3UDVjMzRTTUxxWjVGQXM9</response>

2019-11-22 18:56:03 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:03 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:03 | [Mutex] received everything.

2019-11-22 18:56:03 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:04 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj03dUFMOHJvV2lkTGVURVFWNGxDaw==</auth>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03dUFMOHJvV2lkTGVURVFWNGxDa0xUWW9KMW16SlJxTDY3VlY1YjRQLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N3VBTDhyb1dpZExlVEVRVjRsQ2tMVFlvSjFtekpScUw2N1ZWNWI0UCxwPXlmRVp5bGh4KzRCZmV3anJKZTRsR093aWRScFJNbEx6TzdpNDExcjBxSTg9</response>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:04 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:04 | [Mutex] received everything.

2019-11-22 18:56:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:04 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj03VkNON0E2NUZkSnZvYmdzZ3BLSg==</auth>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03VkNON0E2NUZkSnZvYmdzZ3BLSkVYcXdWVnduajlZVzZCWW1JMTBCLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N1ZDTjdBNjVGZEp2b2Jnc2dwS0pFWHF3VlZ3bmo5WVc2QlltSTEwQixwPUJQUVdvU3F3eEk2eVp1Yng1bENjbGpoOWNxVytkZnpUVFMvam5Ea1NuaW89</response>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:04 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:04 | [Mutex] received everything.

2019-11-22 18:56:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:04 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1CYUpHNlhDbjJBOEprTDlaaUcwTg==</auth>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CYUpHNlhDbjJBOEprTDlaaUcwTjVxd01jcWpTWGxlUnZtUHB4anpDLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QmFKRzZYQ24yQThKa0w5WmlHME41cXdNY3FqU1hsZVJ2bVBweGp6QyxwPWcyRUhqdlRMNWw2emJmWlp3RkJOSDQ4ZjlPaklSQjZNWFJBWDRaOWszTmc9</response>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:04 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:04 | [Mutex] received everything.

2019-11-22 18:56:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:04 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj14c3gybTR5UkUyeTU0Q2VaR09BRg==</auth>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14c3gybTR5UkUyeTU0Q2VaR09BRkFaT0J4NE5uUTVaQ2dYSEVlVXNFLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eHN4Mm00eVJFMnk1NENlWkdPQUZBWk9CeDROblE1WkNnWEhFZVVzRSxwPUp0cDJFUkJFYWFnZmZZL2UwTEMzWXY2WE1TeDlPYUN2bnFodTVubkhsMUk9</response>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:04 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:04 | [Mutex] received everything.

2019-11-22 18:56:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:04 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1zYzc3VDQ3UGxOZVg1M2EwM2RKYQ==</auth>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zYzc3VDQ3UGxOZVg1M2EwM2RKYXRHZHJLWHdmT0hKaGNYV3NiNU1wLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c2M3N1Q0N1BsTmVYNTNhMDNkSmF0R2RyS1h3Zk9ISmhjWFdzYjVNcCxwPXBJRW5FZlZ5Ym4vYzV0cnpuaU9BUkFCYVVxVlpSZUhBZ2s4bHM3bXB3YnM9</response>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:04 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:04 | [Mutex] received everything.

2019-11-22 18:56:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:04 | [Mutex] notify: [event, disconnected]

2019-11-22 18:56:04 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1MZlNoR29QY28wVUlwbER3RGx2Wg==</auth>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MZlNoR29QY28wVUlwbER3RGx2WnBDQktSaExESXJsT2VFeEZaM0gxLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TGZTaEdvUGNvMFVJcGxEd0RsdlpwQ0JLUmhMRElybE9lRXhGWjNIMSxwPURldldUNEo4ZXRDMnEvVCtrSzJTamg2OG1tdFk1U1VqNklId0k4STV2OVk9</response>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:04 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:04 | [Mutex] received everything.

2019-11-22 18:56:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:04 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj04YU9zRm1PYjhheHpwZmVNVHVCdg==</auth>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04YU9zRm1PYjhheHpwZmVNVHVCdmUzQVNreUxwWThtOXVYUktPZHZqLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OGFPc0ZtT2I4YXh6cGZlTVR1QnZlM0FTa3lMcFk4bTl1WFJLT2R2aixwPTlEN0cvaEk5RVE2bVk0anRhaC9Ec21OZTZJc0w5SStxSWIvYzhTUmxxNkU9</response>

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:04 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:04 | [Mutex] notify: [event, disconnected]

2019-11-22 18:56:04 | [Mutex] received everything.

2019-11-22 18:56:04 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:04 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:04 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1IdDhoTmNIa0ZPekh3ZWlkUGZvdA==</auth>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IdDhoTmNIa0ZPekh3ZWlkUGZvdHh0bTRiZTRJTVhJa3k1SlV6cnVBLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SHQ4aE5jSGtGT3pId2VpZFBmb3R4dG00YmU0SU1YSWt5NUpVenJ1QSxwPXExbHZmaFpVQjlrbzdmMktLMGk1T1JOeGJxa1B4cmVaREFxeXcyVVJTZTA9</response>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:05 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:05 | [Mutex] received everything.

2019-11-22 18:56:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:05 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1XMUNXNEJWNzg3dmluRmI5d2N2WQ==</auth>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XMUNXNEJWNzg3dmluRmI5d2N2WTdPaFRldUZRMmwxcnVoV0N1VWJHLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VzFDVzRCVjc4N3ZpbkZiOXdjdlk3T2hUZXVGUTJsMXJ1aFdDdVViRyxwPUpGZlFSb09MR1p2T1piMHEwSmtORlBhUWhWUVBUUVduTVpnaFZ3ZWZMVEE9</response>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:05 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:05 | [Mutex] received everything.

2019-11-22 18:56:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:05 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1vQ1hQcmhwcUZDaHZtdUZaSkNIVw==</auth>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vQ1hQcmhwcUZDaHZtdUZaSkNIV2xUWDV4d1lsS2xnMTBLdnRSbGVXLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b0NYUHJocHFGQ2h2bXVGWkpDSFdsVFg1eHdZbEtsZzEwS3Z0UmxlVyxwPTVYYkwzT2RBQmFsWFBVdW9UWHJrWFhPNVEvQlpubk8xc0taMzFNV2RocVk9</response>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:05 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:05 | [Mutex] received everything.

2019-11-22 18:56:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:05 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1wR1pUb2YzWnREc2NlZzh2ZDllag==</auth>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wR1pUb2YzWnREc2NlZzh2ZDllajlndHQzMUVtZzY5YUl1dkJQSk5aLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cEdaVG9mM1p0RHNjZWc4dmQ5ZWo5Z3R0MzFFbWc2OWFJdXZCUEpOWixwPXhUNnpmMmc2YlY3Z2NZSHMwMG96Z2YrR09kNGJXakV0RUk2U01wR3R0MDg9</response>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:05 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:05 | [Mutex] received everything.

2019-11-22 18:56:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:05 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1PSWVnem5QZVVWNGRJT3ZmU0picw==</auth>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PSWVnem5QZVVWNGRJT3ZmU0pic0dRWjN1M09qU1pJZ0VROTI4WGRlLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T0llZ3puUGVVVjRkSU92ZlNKYnNHUVozdTNPalNaSWdFUTkyOFhkZSxwPUpTSVJvOTBOK3FhWXFVZW5FUmxxbkgvSFlaVWFxNXcybGhBS1ZSWGxaRmc9</response>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:05 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:05 | [Mutex] received everything.

2019-11-22 18:56:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:05 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj03aW1TRFExYmNnOE9ha0wyUk5Nag==</auth>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03aW1TRFExYmNnOE9ha0wyUk5NaktFaGVOTDloODNYb3JJTEI4cE51LHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N2ltU0RRMWJjZzhPYWtMMlJOTWpLRWhlTkw5aDgzWG9ySUxCOHBOdSxwPXYzUmpFVTQyUGU4WHllQ211M1QxUkRvNC9HdW05eVd6L21nMXBhQVgxdGc9</response>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:05 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:05 | [Mutex] received everything.

2019-11-22 18:56:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:05 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1mT05ORXZYZXlFQmlSaXN1MkdNMw==</auth>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mT05ORXZYZXlFQmlSaXN1MkdNM2JoNzd1d2tQRGhMVlNQWUhDUUpMLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Zk9OTkV2WGV5RUJpUmlzdTJHTTNiaDc3dXdrUERoTFZTUFlIQ1FKTCxwPXlZMkVPNWxGa1hoWVBaYlA4WmxyUUxEVzhCcnpBdE1UWDNZRkE2dURjcEU9</response>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:05 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:05 | [Mutex] received everything.

2019-11-22 18:56:05 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlvOHZyaTAwMjcscj1qTFU4T2NVcFRuNGNHOXlTV3BSaA==</auth>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qTFU4T2NVcFRuNGNHOXlTV3BSaDRZNEdEbUlhaHg3QVd0Z0FTQTVHLHM9d2ZsRzJaUHZZUHBrOWc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:05 | user :: user_9o8vri0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9akxVOE9jVXBUbjRjRzl5U1dwUmg0WTRHRG1JYWh4N0FXdGdBU0E1RyxwPW5XcGl2S2JmYXplbXEza3lQUkZKOGo4MlJXb2FwWDI1djlTUFZ1MkY2M0k9</response>

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

2019-11-22 18:56:07 | [Mutex] waiting for: [user]

2019-11-22 18:56:08 | [Mutex] received everything.

2019-11-22 18:56:08 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-22 18:56:08 |

2019-11-22 18:56:08 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 18:56:08 | ------------------------------------

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2e8afdc6

2019-11-22 18:56:08 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@204d1667}, 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@247296b6}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61701c5c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@18edb979}, 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 18:56:08 PST 2019}}}}

2019-11-22 18:56:08 | [Mutex] waiting for: [registration]

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@505b7a2d

2019-11-22 18:56:08 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@204d1667}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@247296b6}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61701c5c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@18edb979}, 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 18:56:08 PST 2019}}}}

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@602c81b6

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

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

2019-11-22 18:56:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@15fe313}

2019-11-22 18:56:08 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:56:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@748ca430

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@7f0d329e

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

2019-11-22 18:56:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7b282df8}

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

2019-11-22 18:56:08 | user :: null >> <iq to="localhost" id="lJcEFtZjPMDhM15l5zCpj3e" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 18:56:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8738c798}

2019-11-22 18:56:08 | user :: null << <iq id="lJcEFtZjPMDhM15l5zCpj3e" type="result" from="localhost" xmlns="jabber:client"><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 18:56:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5111ef5}

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@14ad9743

2019-11-22 18:56:08 | user :: null >> <iq to="localhost" id="CI7HPMX25bHJQ8BCt9Axdth" type="set"><query xmlns="jabber:iq:register"><username>user_3nqfqz0028</username><password>user_3nqfqz0028</password><email>84b48a62-f9f5-4198-83e7-67a2288a7f51@localhost</email></query></iq>

2019-11-22 18:56:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4c61a801}

2019-11-22 18:56:08 | user :: null << <iq id="CI7HPMX25bHJQ8BCt9Axdth" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-22 18:56:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@222ce8a}

2019-11-22 18:56:08 | [Mutex] received everything.

2019-11-22 18:56:08 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 18:56:08 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@15fe313, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7b282df8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@204d1667}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@247296b6}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61701c5c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@18edb979}, 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 18:56:08 PST 2019}}}}

2019-11-22 18:56:08 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@15fe313, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7b282df8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@204d1667}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@247296b6}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@61701c5c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@18edb979}, 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 18:56:08 PST 2019}}}}

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@385f64db

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@35343393

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4d5bbdf9

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@59196c46

2019-11-22 18:56:08 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1aa3b202

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

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNucWZxejAwMjgscj10UFc1SlBtdUg2S2tETGkyU1RmZg==</auth>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10UFc1SlBtdUg2S2tETGkyU1RmZnRVVXVjYWpsT3RWM05VbERFMTdxLHM9ZElZdjZoc2kzVThoTXc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFBXNUpQbXVINktrRExpMlNUZmZ0VVV1Y2FqbE90VjNOVWxERTE3cSxwPXgwZkI1ZjAvZmdQc0JENUVsNkMra2hnSjJIT2t5YUhOY1F4NnIrS0ZQRGs9</response>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0rYjkzMDdzVUFvckJFUnhaT0UwQktTM0ErWXNISHBUdW9WR3VCdkhuM3pZPQ==</success>

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

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <iq xmlns="jabber:client" id="FGZlODhT7CGHORV8DpR3jKz" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost << <iq id="FGZlODhT7CGHORV8DpR3jKz" type="result" to="user_3nqfqz0028@localhost/993927746-tigase-20" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_3nqfqz0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="h1YfU3jUbv3r5iFlUhBn9HS" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost/993927746-tigase-20 << <iq id="h1YfU3jUbv3r5iFlUhBn9HS" type="result" to="user_3nqfqz0028@localhost/993927746-tigase-20" xmlns="jabber:client"/>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="N2ZhYbzqdzbHBkJtaNDrhXo" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost/993927746-tigase-20 >> <iq id="6MbP5iZ6drdLUgR8vdINJvl" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost/993927746-tigase-20 << <enabled id="bf4a0b33-b77d-45c2-990a-118c7a4f3158" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/>

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

2019-11-22 18:56:08 | Disconnecting

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

2019-11-22 18:56:08 | [Mutex] notify: [disconnected]

2019-11-22 18:56:08 | [Mutex] received everything.

2019-11-22 18:56:08 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNucWZxejAwMjgscj10enZjS0REaG5sOVI5R0hsajJZeA==</auth>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10enZjS0REaG5sOVI5R0hsajJZeFk0TjNoNkcwVHRZZUxpZlRuS21ULHM9ZElZdjZoc2kzVThoTXc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dHp2Y0tERGhubDlSOUdIbGoyWXhZNE4zaDZHMFR0WWVMaWZUbkttVCxwPUx1N1JIM0tmL3p2Vlc1RSs2TThuVVFHOTZ4YVplUEF2MUdxUGovdHRBNmc9</response>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:08 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:08 | [Mutex] received everything.

2019-11-22 18:56:08 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:08 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNucWZxejAwMjgscj1sM3lLc1VOZlhycjJZc3dsQUp1eA==</auth>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sM3lLc1VOZlhycjJZc3dsQUp1eEV0cmExdGpGVGJXbzBxSUxacnRzLHM9ZElZdjZoc2kzVThoTXc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bDN5S3NVTmZYcnIyWXN3bEFKdXhFdHJhMXRqRlRiV28wcUlMWnJ0cyxwPVR1S0w1RTA5MzlmNmFLYnMrRERrdlRBY1AwcjAycHpYS3QwV2JLQTNsdHc9</response>

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:08 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:08 | [Mutex] received everything.

2019-11-22 18:56:08 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:08 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:08 | user :: user_3nqfqz0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNucWZxejAwMjgscj1YeTRja05Qczk4Z0JyWG8xSDcwaA==</auth>

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YeTRja05Qczk4Z0JyWG8xSDcwaHBMMDhaaXpDSHhVdTE3ZG5ESFA5LHM9ZElZdjZoc2kzVThoTXc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WHk0Y2tOUHM5OGdCclhvMUg3MGhwTDA4Wml6Q0h4VXUxN2RuREhQOSxwPVFqZy9hUnFvOUNMWVVsOXc4amZqdUlmcnZOZGE3d1gyT1puWkNiSmlRT289</response>

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:09 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:09 | [Mutex] received everything.

2019-11-22 18:56:09 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:09 | [Mutex] notify: [event, disconnected]

2019-11-22 18:56:09 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNucWZxejAwMjgscj11N0lEaXlMVGNCY09sQ2FwNHBzbw==</auth>

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11N0lEaXlMVGNCY09sQ2FwNHBzb3FxcU5wYVBVa3pBdmdvUlB5UFE5LHM9ZElZdjZoc2kzVThoTXc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dTdJRGl5TFRjQmNPbENhcDRwc29xcXFOcGFQVWt6QXZnb1JQeVBROSxwPTRjQmlHNmxxbFY1QVJkS3Vzdk9KTy9LYnZIdFJEeElVMnhFRnRHZGlDZ1k9</response>

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:09 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:09 | [Mutex] received everything.

2019-11-22 18:56:09 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzNucWZxejAwMjgscj1OdWV5MHlxak5EdlBZTkJhWkNsMA==</auth>

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OdWV5MHlxak5EdlBZTkJhWkNsMFk4RElaRW5nNU5pcHpBbVMxVWZxLHM9ZElZdjZoc2kzVThoTXc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TnVleTB5cWpORHZQWU5CYVpDbDBZOERJWkVuZzVOaXB6QW1TMVVmcSxwPVVLNUN6NGxVRXJmSlhsU2d4NFRNdEt3aE5UYXA2bUVKVVl6MFNYbURZY289</response>

2019-11-22 18:56:09 | user :: user_3nqfqz0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:11 | [Mutex] waiting for: [user]

2019-11-22 18:56:11 | [Mutex] received everything.

2019-11-22 18:56:11 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-22 18:56:11 |

2019-11-22 18:56:11 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 18:56:11 | ------------------------------------

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@328caa81

2019-11-22 18:56:11 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c4b52a0}, 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@3874c1f1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d76589b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2af93d16}, 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 18:56:11 PST 2019}}}}

2019-11-22 18:56:11 | [Mutex] waiting for: [registration]

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4cc1a4bb

2019-11-22 18:56:11 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c4b52a0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@3874c1f1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d76589b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2af93d16}, 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 18:56:11 PST 2019}}}}

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@52a49f9b

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

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

2019-11-22 18:56:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d59a7d4}

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

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

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7e2b38e4

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3f8eafe6

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

2019-11-22 18:56:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@49a0b7cb}

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

2019-11-22 18:56:11 | user :: null >> <iq to="localhost" id="cFKthTaMTcDtePNDBpWXV4B" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 18:56:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e235d0b7}

2019-11-22 18:56:11 | user :: null << <iq id="cFKthTaMTcDtePNDBpWXV4B" type="result" from="localhost" xmlns="jabber:client"><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 18:56:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1917de2c}

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3edc39f2

2019-11-22 18:56:11 | user :: null >> <iq to="localhost" id="FN6zgx5vl4Avq5n2r15vdyb" type="set"><query xmlns="jabber:iq:register"><username>user_8eqeb0029</username><password>user_8eqeb0029</password><email>47e9bd19-8613-410f-bd6d-6caeec046ba7@localhost</email></query></iq>

2019-11-22 18:56:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@370ee68f}

2019-11-22 18:56:11 | user :: null << <iq id="FN6zgx5vl4Avq5n2r15vdyb" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-22 18:56:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@74674050}

2019-11-22 18:56:11 | [Mutex] received everything.

2019-11-22 18:56:11 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 18:56:11 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d59a7d4, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@49a0b7cb]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c4b52a0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@3874c1f1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d76589b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2af93d16}, 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 18:56:11 PST 2019}}}}

2019-11-22 18:56:11 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d59a7d4, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@49a0b7cb]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3c4b52a0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@3874c1f1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7d76589b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2af93d16}, 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 18:56:11 PST 2019}}}}

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3835aff8

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1ff4e06c

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@40b849c9

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@e13f44e

2019-11-22 18:56:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1b4cd01b

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

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhlcWViMDAyOSxyPUlNdkFFZ0FDM1dLeUtCeE1CY0xH</auth>

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JTXZBRWdBQzNXS3lLQnhNQmNMR2hib1FrdzQ4T1JRSHU3YlZYc0lzLHM9NEpmaVNNd2xwQ3pDL0E9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SU12QUVnQUMzV0t5S0J4TUJjTEdoYm9Ra3c0OE9SUUh1N2JWWHNJcyxwPWV5Y0tqK21pQkEySWJxaXNLL3FtUEM5OUR0N1FxcTk2UW9TN0IrY1A0aVU9</response>

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1DWWNJOHEzQUd1S0FKRUh5WGVBeHdPUzU2NXJnRXdoMjdDQkhEclpYTWw4PQ==</success>

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

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost >> <iq xmlns="jabber:client" id="bO7drdLUgR8vdINJvlTUTNO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost << <iq id="bO7drdLUgR8vdINJvlTUTNO" type="result" to="user_8eqeb0029@localhost/993927746-tigase-21" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_8eqeb0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="P70dDyt5dLJAfveVTXj1wdV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost/993927746-tigase-21 << <iq id="P70dDyt5dLJAfveVTXj1wdV" type="result" to="user_8eqeb0029@localhost/993927746-tigase-21" xmlns="jabber:client"/>

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="e3MR6EDGBp6zhBxhGrT0tZ9" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost/993927746-tigase-21 << <enabled id="83e2ba86-3ee6-49c0-9fda-90cb6731c18c" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/>

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost/993927746-tigase-21 >> <iq id="2UjZneDLX2t49jXfScJSZbE" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 18:56:11 | Disconnecting

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

2019-11-22 18:56:11 | [Mutex] notify: [disconnected]

2019-11-22 18:56:11 | [Mutex] received everything.

2019-11-22 18:56:11 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfOGVxZWIwMDI5ACAtIC0gLSAtIC0=</auth>

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

2019-11-22 18:56:11 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:11 | [Mutex] notify: [event, disconnected]

2019-11-22 18:56:11 | [Mutex] received everything.

2019-11-22 18:56:11 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:11 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:11 | user :: user_8eqeb0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfOGVxZWIwMDI5ACAtIC0gLSAtIC0=</auth>

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:12 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:12 | [Mutex] received everything.

2019-11-22 18:56:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:12 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhlcWViMDAyOSxyPVFieDc5VnUyN1ZhaXJnVGpEcU5X</auth>

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RYng3OVZ1MjdWYWlyZ1RqRHFOV043U1ltSmZOSUViWUFxdHFLSG9MLHM9NEpmaVNNd2xwQ3pDL0E9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UWJ4NzlWdTI3VmFpcmdUakRxTldON1NZbUpmTklFYllBcXRxS0hvTCxwPTU3SlJVdVFxTWxOM1lYK203Z1ZPLzhzeWdmUDNKRmhJcWR4Rk05RmFrOVk9</response>

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:12 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:12 | [Mutex] received everything.

2019-11-22 18:56:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:12 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyXzhlcWViMDAyOSxyPW1PVVFod01QbGdUWXFGdkg5dkpO</auth>

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tT1VRaHdNUGxnVFlxRnZIOXZKTjF1MURrRVV5dFZ2Uk4wTXJjUzhQLHM9TlhCelUrSWRJSmlyeGc9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bU9VUWh3TVBsZ1RZcUZ2SDl2Sk4xdTFEa0VVeXRWdlJOME1yY1M4UCxwPXQycWQ0TlJVQTdrZC9WYjFETkZvMFZYcjE3Yz0=</response>

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:12 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:12 | [Mutex] received everything.

2019-11-22 18:56:12 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhlcWViMDAyOSxyPWJrQVIza3Zyckl3NklmRnhkeXNM</auth>

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ia0FSM2t2cnJJdzZJZkZ4ZHlzTFJhQ0NnTndKRHRlZ0YxV3RINllhLHM9NEpmaVNNd2xwQ3pDL0E9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YmtBUjNrdnJySXc2SWZGeGR5c0xSYUNDZ053SkR0ZWdGMVd0SDZZYSxwPXM1UVAyY3pybTBqenFhTjlGaThhUUtVQWVMRWN5d1htWlpodytJQlhMWE09</response>

2019-11-22 18:56:12 | user :: user_8eqeb0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:14 | [Mutex] waiting for: [user]

2019-11-22 18:56:14 | [Mutex] received everything.

2019-11-22 18:56:14 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-22 18:56:14 |

2019-11-22 18:56:14 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 18:56:14 | ------------------------------------

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3c62dffa

2019-11-22 18:56:14 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@32a52606}, 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@369ab48a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@73982c3d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@592fa0bb}, 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 18:56:14 PST 2019}}}}

2019-11-22 18:56:14 | [Mutex] waiting for: [registration]

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4221388e

2019-11-22 18:56:14 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@32a52606}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@369ab48a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@73982c3d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@592fa0bb}, 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 18:56:14 PST 2019}}}}

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@217ceaa4

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

2019-11-22 18:56:14 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@13b7d372}

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

2019-11-22 18:56:14 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 18:56:14 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@373983c7

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@7c9738e6

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

2019-11-22 18:56:14 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3a78c41a}

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

2019-11-22 18:56:14 | user :: null >> <iq to="localhost" id="wfet7DFON5Bk3etXfP2wnaz" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 18:56:14 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1f71162a}

2019-11-22 18:56:14 | user :: null << <iq id="wfet7DFON5Bk3etXfP2wnaz" type="result" from="localhost" xmlns="jabber:client"><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 18:56:14 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@17f9ac64}

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6ca522e7

2019-11-22 18:56:14 | user :: null >> <iq to="localhost" id="FVePMz9DBACzylT4v9l1fCj" type="set"><query xmlns="jabber:iq:register"><username>user_7zi45o0030</username><password>user_7zi45o0030</password><email>3e23f5d7-8870-445c-b64e-cb4aa724f40d@localhost</email></query></iq>

2019-11-22 18:56:14 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6aef8e24}

2019-11-22 18:56:14 | user :: null << <iq id="FVePMz9DBACzylT4v9l1fCj" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-22 18:56:14 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@29b0679d}

2019-11-22 18:56:14 | [Mutex] received everything.

2019-11-22 18:56:14 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 18:56:14 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@13b7d372, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3a78c41a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@32a52606}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@369ab48a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@73982c3d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@592fa0bb}, 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 18:56:14 PST 2019}}}}

2019-11-22 18:56:14 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@13b7d372, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3a78c41a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@32a52606}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@369ab48a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@73982c3d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@592fa0bb}, 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 18:56:14 PST 2019}}}}

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@55143ea5

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@fd422ef

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4aa38be8

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@600591ae

2019-11-22 18:56:14 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@14107a1d

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

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzd6aTQ1bzAwMzAscj1MMkFsZ25TUUNZMVV6TkpveFRDYw==</auth>

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MMkFsZ25TUUNZMVV6TkpveFRDY0VoV1lLRGU3bk4xMzIxUUc3djZpLHM9VFgwYnBIcFllVnV3Y2c9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TDJBbGduU1FDWTFVek5Kb3hUQ2NFaFdZS0RlN25OMTMyMVFHN3Y2aSxwPVduUy9nU1o5Q0lDcUN3RXN2dTlsSW9DNUd3RGRmbGVGVTVYeVlUSU9Xa289</response>

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1SdEM1K0FST1JteHkzb2srOHpXL1RsVGtsVDR5QTVDbmtwSlpiY3RHaUcwPQ==</success>

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

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost >> <iq xmlns="jabber:client" id="6ZofVYlODhT7CGHORV8DpR3" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost << <iq id="6ZofVYlODhT7CGHORV8DpR3" type="result" to="user_7zi45o0030@localhost/993927746-tigase-22" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_7zi45o0030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="LaT8ILW7raHx7zlOHp2x7pd" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost/993927746-tigase-22 << <iq id="LaT8ILW7raHx7zlOHp2x7pd" type="result" to="user_7zi45o0030@localhost/993927746-tigase-22" xmlns="jabber:client"/>

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="WbUZ6hzmbpZn9MJXlO1alHJ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost/993927746-tigase-22 << <enabled id="f2d80791-c520-4599-8616-1fd9045cbe86" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/>

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost/993927746-tigase-22 >> <iq id="cSXT7zwuj2jPWfDjX7mNBqj" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 18:56:14 | Disconnecting

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

2019-11-22 18:56:14 | [Mutex] notify: [disconnected]

2019-11-22 18:56:14 | [Mutex] received everything.

2019-11-22 18:56:14 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:14 | user :: user_7zi45o0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzd6aTQ1bzAwMzAscj11SHY1dWp1bWRocHpwbW5Ka3RERg==</auth>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11SHY1dWp1bWRocHpwbW5Ka3RERm9JeEF1MVhUUHZveTlYZmpEU21qLHM9VFgwYnBIcFllVnV3Y2c9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dUh2NXVqdW1kaHB6cG1uSmt0REZvSXhBdTFYVFB2b3k5WGZqRFNtaixwPVlvYndqSXA4RjdBR2dYZ0YyYWd3SEkvY0hlYjhROUg5VVVEK3BRUFNUUms9</response>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:15 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:15 | [Mutex] received everything.

2019-11-22 18:56:15 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:15 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzd6aTQ1bzAwMzAscj1TQVVuVFB3dHN2eG9nSWc2UktaZg==</auth>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TQVVuVFB3dHN2eG9nSWc2UktaZmczSElSME5LYkJyWm5FUkFweVByLHM9VFgwYnBIcFllVnV3Y2c9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U0FVblRQd3RzdnhvZ0lnNlJLWmZnM0hJUjBOS2JCclpuRVJBcHlQcixwPXVOREhrUjBPaWNmSExkZG9aTlFaek85VE1XUFJQb1BaSzVMWXZTNmVJL0U9</response>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:15 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:15 | [Mutex] received everything.

2019-11-22 18:56:15 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 18:56:15 | [Mutex] waiting for: [event]

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

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzd6aTQ1bzAwMzAscj05dnZERE5aUkxLd1dYMVNCbzJ1eg==</auth>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05dnZERE5aUkxLd1dYMVNCbzJ1ejBZbTlJcGZSczZZbm9lbWs0QmhDLHM9VFgwYnBIcFllVnV3Y2c9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OXZ2REROWlJMS3dXWDFTQm8ydXowWW05SXBmUnM2WW5vZW1rNEJoQyxwPTVvTnpVa0JCbS9jUG5MRGM3Z0RPcFF1KzlSa0szQ2tOaWlEbmh0M3VIMU09</response>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-22 18:56:15 | [Mutex] notify: [event, authFailed]

2019-11-22 18:56:15 | [Mutex] received everything.

2019-11-22 18:56:15 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzd6aTQ1bzAwMzAscj12MWpYNlhQdjFIdGtFdHZrTTdzMA==</auth>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12MWpYNlhQdjFIdGtFdHZrTTdzMEpsRU5ucDlzRjdWaFFMcWtjY0NnLHM9VFgwYnBIcFllVnV3Y2c9PSxpPTQwOTY=</challenge>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9djFqWDZYUHYxSHRrRXR2a003czBKbEVObnA5c0Y3VmhRTHFrY2NDZyxwPVIzQUVTN1VQWExKcjZRZTN6QmJTT3VWOFNiOUtwTFZxVWkvbzk5MEozd0k9</response>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1wTUFzb3l3SWtDR2ZOVmxESlNzNyt0c0dLT0V6MkRTUW1LajJPa21TSXhNPQ==</success>

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

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost >> <iq xmlns="jabber:client" id="0lkFvpdUZtnS9qRJNVeU9IF" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost << <iq id="0lkFvpdUZtnS9qRJNVeU9IF" type="result" to="user_7zi45o0030@localhost/993927746-tigase-23" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_7zi45o0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="hliTcDtePNDBpWXV4BfFJRc" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost/993927746-tigase-23 << <iq id="hliTcDtePNDBpWXV4BfFJRc" type="result" to="user_7zi45o0030@localhost/993927746-tigase-23" xmlns="jabber:client"/>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="3jaHSVl7m7mJthTaMTcDteP" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost/993927746-tigase-23 << <enabled id="320bfe25-7303-4beb-936b-4c4befa8ab71" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/>

2019-11-22 18:56:15 | user :: user_7zi45o0030@localhost/993927746-tigase-23 >> <iq id="4kbON5Bk3etXfP2wnazlYjL" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 18:56:15 | Disconnecting

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

2019-11-22 18:56:15 | [Mutex] notify: [disconnected]

2019-11-22 18:56:15 | [Mutex] received everything.

2019-11-22 18:56:17 | [Mutex] waiting for: [user]

2019-11-22 18:56:17 | [Mutex] received everything.

2019-11-22 18:56:17 | [Mutex] isItemNotified: user:ok:true :: true