Brute Force Prevention

2019-11-26 18:57:30 |

2019-11-26 18:57:30 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-26 18:57:30 | ------------------------------------

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3da33bdb

2019-11-26 18:57:30 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7270da70}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3364c21f}, 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@375b50ab}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7259c824}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@56004857}, 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=Tue Nov 26 18:57:30 PST 2019}}}}

2019-11-26 18:57:30 | [Mutex] waiting for: [registration]

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@43e11cb2

2019-11-26 18:57:30 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3364c21f}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@375b50ab}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7259c824}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@56004857}, 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=Tue Nov 26 18:57:30 PST 2019}}}}

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2e52c26d

2019-11-26 18:57:30 | 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-26 18:57:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1276376b}

2019-11-26 18:57:30 | 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-26 18:57:30 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@46e08782

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@daf1760

2019-11-26 18:57:30 | 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-26 18:57:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3556ed12}

2019-11-26 18:57:30 | 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-26 18:57:30 | user :: null >> <iq to="localhost" id="sKvq7jKWbHtavgYazcLKJIs" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-26 18:57:30 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5f702d7a}

2019-11-26 18:57:30 | user :: null << <iq from="localhost" id="sKvq7jKWbHtavgYazcLKJIs" xmlns="jabber:client" type="result"><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-26 18:57:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@163849bc}

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5426106e

2019-11-26 18:57:30 | user :: null >> <iq to="localhost" id="iuHm48t24yzwoeJxcQZjHCp" type="set"><query xmlns="jabber:iq:register"><username>user_wfz6uu0027</username><password>user_wfz6uu0027</password><email>24bb200c-a712-47fd-9471-bb23adb9c218@localhost</email></query></iq>

2019-11-26 18:57:30 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@edf783eb}

2019-11-26 18:57:30 | user :: null << <iq from="localhost" id="iuHm48t24yzwoeJxcQZjHCp" xmlns="jabber:client" type="result"/>

2019-11-26 18:57:30 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@21c7199d}

2019-11-26 18:57:30 | [Mutex] received everything.

2019-11-26 18:57:30 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 18:57:30 | 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;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1276376b, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3556ed12]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3364c21f}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@375b50ab}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7259c824}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@56004857}, 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=Tue Nov 26 18:57:30 PST 2019}}}}

2019-11-26 18:57:30 | 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;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1276376b, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3556ed12]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3364c21f}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@375b50ab}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7259c824}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@56004857}, 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=Tue Nov 26 18:57:30 PST 2019}}}}

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@237b4eca

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@775a96b0

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@139b5d55

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@a09a54a

2019-11-26 18:57:30 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@73fda7df

2019-11-26 18:57:30 | user :: user_wfz6uu0027@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-26 18:57:30 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1DV2xFWVBWdEtYVXBoemY2Q3FaMA==</auth>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DV2xFWVBWdEtYVXBoemY2Q3FaMFlQYlhQV2MwM1ZPa1dmTTl3RjJTLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q1dsRVlQVnRLWFVwaHpmNkNxWjBZUGJYUFdjMDNWT2tXZk05d0YyUyxwPStKWHJYTHRnY2VPdDFJTXI0T2M1Z1c2S3ZSMTliWTdBenMyQUN3bUhDc2M9</response>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VSUNaN2E1UlE1UTVaTnhjNVRtblpqTlYvcTM3TGt1NFUxcEdCcmNPTGpFPQ==</success>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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 hash="SHA-1" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <iq xmlns="jabber:client" id="CB0eU2jGJGBsWZ36y6pUO2x" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost << <iq to="user_wfz6uu0027@localhost/993927746-tigase-19" id="CB0eU2jGJGBsWZ36y6pUO2x" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_wfz6uu0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="9Fax8DudGoTRIMyjIqgZm4A" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost/993927746-tigase-19 << <iq to="user_wfz6uu0027@localhost/993927746-tigase-19" id="9Fax8DudGoTRIMyjIqgZm4A" xmlns="jabber:client" type="result"/>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="fIhydv0mIDmIQ9GIS17maDB" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost/993927746-tigase-19 << <enabled location="d4270859fb27" id="87c37870-23e3-45aa-bdf1-6c89011e69da" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost/993927746-tigase-19 >> <iq id="dHcBsWZ36y6pUO2xsgYdv8I" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost/993927746-tigase-19 << <iq from="localhost" to="user_wfz6uu0027@localhost/993927746-tigase-19" id="fIhydv0mIDmIQ9GIS17maDB" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost/993927746-tigase-19 << <iq to="user_wfz6uu0027@localhost/993927746-tigase-19" id="dHcBsWZ36y6pUO2xsgYdv8I" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:57:31 | Disconnecting

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

2019-11-26 18:57:31 | [Mutex] notify: [disconnected]

2019-11-26 18:57:31 | [Mutex] received everything.

2019-11-26 18:57:31 | [Mutex] waiting for: [event]

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1mbGQ4amFGekRETDhQSVlhTDNBZA==</auth>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mbGQ4amFGekRETDhQSVlhTDNBZDV3QnhIczh3bFVzSzhyN2Jib2hILHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZmxkOGphRnpEREw4UElZYUwzQWQ1d0J4SHM4d2xVc0s4cjdiYm9oSCxwPTZYVkF6aG9vcnJ3WmNiL1BvM1pHVmM4cU9BR2pPTUZqT1FpbDVjZWxqVFk9</response>

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

2019-11-26 18:57:31 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:31 | [Mutex] received everything.

2019-11-26 18:57:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:31 | [Mutex] waiting for: [event]

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1nUzlrTUFDZlN2eHVhNVZwYWxIZw==</auth>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nUzlrTUFDZlN2eHVhNVZwYWxIZ1pLRTJvWWdiWVdnNE8xZTMyQ3ZrLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z1M5a01BQ2ZTdnh1YTVWcGFsSGdaS0Uyb1lnYllXZzRPMWUzMkN2ayxwPTRhRTFBNlFyZFIxakJURkd5UlpNa2RhVTNsNk5ScnhqQlBKT00xc2tuODA9</response>

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

2019-11-26 18:57:31 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:31 | [Mutex] received everything.

2019-11-26 18:57:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:31 | [Mutex] waiting for: [event]

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1NcEFWakdWUEdwZk5GOXhDZHlFMg==</auth>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NcEFWakdWUEdwZk5GOXhDZHlFMnpUSDhnb0RWZUd3RjJaUVVrNmtLLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TXBBVmpHVlBHcGZORjl4Q2R5RTJ6VEg4Z29EVmVHd0YyWlFVazZrSyxwPWhuaDNPRmQ1ejNYZmJ3Q0ljbVV6RGJIcVpwWmZyTzJ5cm91L2duc0pMTGs9</response>

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

2019-11-26 18:57:31 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:31 | [Mutex] notify: [event, disconnected]

2019-11-26 18:57:31 | [Mutex] received everything.

2019-11-26 18:57:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:31 | [Mutex] waiting for: [event]

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1qQlRxVkpFaG9QTFVsMDVqOHBQMA==</auth>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qQlRxVkpFaG9QTFVsMDVqOHBQMExoQTIwQlZFU25PcFhva1hDOWg5LHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9akJUcVZKRWhvUExVbDA1ajhwUDBMaEEyMEJWRVNuT3BYb2tYQzloOSxwPWE2b3hzdnJmZy9aSlpjOEVDeDJrRHk1LzV6aUowdENURHgyR3ZVZjkzOEE9</response>

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

2019-11-26 18:57:31 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:31 | [Mutex] received everything.

2019-11-26 18:57:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:31 | [Mutex] waiting for: [event]

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1yUE1oQWVoenhUQ2hqVFFNcnRKNw==</auth>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yUE1oQWVoenhUQ2hqVFFNcnRKN2xMckEwMGxGeUgzS2VtdVFtdkVvLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9clBNaEFlaHp4VENoalRRTXJ0SjdsTHJBMDBsRnlIM0tlbXVRbXZFbyxwPXU4QTlCVG9XL3ZRdnRWRTJHWlNaTjkzVEthcWZvYmQ3QThTelpObTZJQzA9</response>

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

2019-11-26 18:57:31 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:31 | [Mutex] received everything.

2019-11-26 18:57:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:31 | [Mutex] waiting for: [event]

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj10Q0NNRzlUelk1M0oxYzRNd2NDcw==</auth>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10Q0NNRzlUelk1M0oxYzRNd2NDc21GVFBkR2lWNXRqazR2Vzk2QU5TLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dENDTUc5VHpZNTNKMWM0TXdjQ3NtRlRQZEdpVjV0ams0dlc5NkFOUyxwPUhoTjFYMk5oVGtIRy94ZjFjRW1LUng3NjFvbXdUaTdpRE4yRXdrbVZuQkk9</response>

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

2019-11-26 18:57:31 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:31 | [Mutex] notify: [event, disconnected]

2019-11-26 18:57:31 | [Mutex] received everything.

2019-11-26 18:57:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:31 | [Mutex] waiting for: [event]

2019-11-26 18:57:31 | user :: user_wfz6uu0027@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-26 18:57:31 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1mdjU4UGtvQWdTdU96Tm9PODFRRg==</auth>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mdjU4UGtvQWdTdU96Tm9PODFRRnVzZzI3RWVzZlhrWmtabWdhUmZULHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZnY1OFBrb0FnU3VPek5vTzgxUUZ1c2cyN0Vlc2ZYa1prWm1nYVJmVCxwPTFFNEgvZDFVc0xFWmNRbE4zNitYVFVib1FLSzVLQnN2enVHb25wYnFMVlE9</response>

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

2019-11-26 18:57:32 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:32 | [Mutex] received everything.

2019-11-26 18:57:32 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:32 | [Mutex] waiting for: [event]

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1wckpWSENmYW1tVDRYVGFCUTBoQg==</auth>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wckpWSENmYW1tVDRYVGFCUTBoQm56YlhGc1NvSUcyd1pianZLbzc1LHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cHJKVkhDZmFtbVQ0WFRhQlEwaEJuemJYRnNTb0lHMndaYmp2S283NSxwPTRFMmVGUThjQVVkemJJQzFCeUVCZUtTN3Nray9HY3RyRHVXWWhnTHlzS3c9</response>

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

2019-11-26 18:57:32 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:32 | [Mutex] received everything.

2019-11-26 18:57:32 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:32 | [Mutex] waiting for: [event]

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj0wTGltam1JV1FKck11MlFMcmxLTw==</auth>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wTGltam1JV1FKck11MlFMcmxLT3lIY01KZFdNWU91SzhSVmpTbjN1LHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MExpbWptSVdRSnJNdTJRTHJsS095SGNNSmRXTVlPdUs4UlZqU24zdSxwPWNsMHdtdkdJQXpzVzJaT25LVTIrTDlnbzVGRzhPdGd5SFBRL2xQTmhwY3c9</response>

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

2019-11-26 18:57:32 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:32 | [Mutex] received everything.

2019-11-26 18:57:32 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:32 | [Mutex] waiting for: [event]

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1tWGxPbVBSNmt3ZkplbHdybHMySw==</auth>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tWGxPbVBSNmt3ZkplbHdybHMySzFYNTlwd3JCUklleGR0bVRYNDdVLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bVhsT21QUjZrd2ZKZWx3cmxzMksxWDU5cHdyQlJJZXhkdG1UWDQ3VSxwPXlGMkpMOTlNeXZHeXNxSEZud1lIUWY2SmZrNlRCS25WVThpdzErY05taTg9</response>

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

2019-11-26 18:57:32 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:32 | [Mutex] received everything.

2019-11-26 18:57:32 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:32 | [Mutex] waiting for: [event]

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1IRHY4cEZPMk4wR0MxZ2c3SmxZSw==</auth>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IRHY4cEZPMk4wR0MxZ2c3SmxZS1Nmdzk1SHdkRkNCQmRjUVJMRmUzLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SER2OHBGTzJOMEdDMWdnN0psWUtTZnc5NUh3ZEZDQkJkY1FSTEZlMyxwPWRhQWNrTzNWclhYZS9sRnNLSzZYTnhTNzAyYzhVL3JUaVo3M0NJa3BrSGM9</response>

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

2019-11-26 18:57:32 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:32 | [Mutex] received everything.

2019-11-26 18:57:32 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:32 | [Mutex] waiting for: [event]

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1ucnVMaTN6bENDQ0dGTDQ5NVg5Qw==</auth>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ucnVMaTN6bENDQ0dGTDQ5NVg5Q2JSclpMUHlVQUt6bWFNanZZTDNzLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bnJ1TGkzemxDQ0NHRkw0OTVYOUNiUnJaTFB5VUFLem1hTWp2WUwzcyxwPWU0Q1lNbERRVXlRVDBRemZyZXprOHloQUNIWDlyR3lVUTgzNXY1S0prTEk9</response>

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

2019-11-26 18:57:32 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:32 | [Mutex] received everything.

2019-11-26 18:57:32 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:32 | [Mutex] waiting for: [event]

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1PdlBXcHVteDVmd2lyQ1F4VVk4VA==</auth>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PdlBXcHVteDVmd2lyQ1F4VVk4VGNObGNkWFFLSGVpR1p6a1VyNkI5LHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T3ZQV3B1bXg1ZndpckNReFVZOFRjTmxjZFhRS0hlaUdaemtVcjZCOSxwPUR6ZVJIQjhBcGNnd1cxUHdYbFl5MUR5MFdvQzZlZ1UxWHZDSTVDWlYwWUU9</response>

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

2019-11-26 18:57:32 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:32 | [Mutex] received everything.

2019-11-26 18:57:32 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:32 | [Mutex] waiting for: [event]

2019-11-26 18:57:32 | user :: user_wfz6uu0027@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-26 18:57:32 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj04c1J1bkpiNWZpRm5oUUsyR2Y3VQ==</auth>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04c1J1bkpiNWZpRm5oUUsyR2Y3VWd2MG93ZUxETHRNZVlSNmRwbW9vLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OHNSdW5KYjVmaUZuaFFLMkdmN1VndjBvd2VMREx0TWVZUjZkcG1vbyxwPVA5dmJwVHRDelo4ekVGUzFsM1Y3T24xWFRlL3Blemd2QjNwa244MTV1VDg9</response>

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

2019-11-26 18:57:33 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:33 | [Mutex] notify: [event, disconnected]

2019-11-26 18:57:33 | [Mutex] received everything.

2019-11-26 18:57:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:33 | [Mutex] waiting for: [event]

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1EYUZMQTdxWFlYM1pRSEZSR0FJMg==</auth>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EYUZMQTdxWFlYM1pRSEZSR0FJMkxmd044NU1yblc3Y09GMDZyYURELHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RGFGTEE3cVhZWDNaUUhGUkdBSTJMZndOODVNcm5XN2NPRjA2cmFERCxwPWI5cmZYWW5TVG94NHhMMlZ2YTI3UXk3SkpjVFA4UzRUVVFCeDc5QW11c1U9</response>

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

2019-11-26 18:57:33 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:33 | [Mutex] received everything.

2019-11-26 18:57:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:33 | [Mutex] waiting for: [event]

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1YQVZIUHc3NkNvUHRSWEhTdURyZA==</auth>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YQVZIUHc3NkNvUHRSWEhTdURyZHZvaXU0MHFwbENkeGNjbHl4eTdBLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WEFWSFB3NzZDb1B0UlhIU3VEcmR2b2l1NDBxcGxDZHhjY2x5eHk3QSxwPXY5LzFxNkFpNEpjcDBsbGozM2lINFAxOTdRdFZNY1lIaTNFQUNWa2REcTg9</response>

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

2019-11-26 18:57:33 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:33 | [Mutex] received everything.

2019-11-26 18:57:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:33 | [Mutex] waiting for: [event]

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1reVIwODJKUFBuelNWcGhodmhRbA==</auth>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1reVIwODJKUFBuelNWcGhodmhRbFVqclN5S3NRSEllUEdNVkRTUU9sLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a3lSMDgySlBQbnpTVnBoaHZoUWxVanJTeUtzUUhJZVBHTVZEU1FPbCxwPTZKMHZqQmRGR1lFL0pHWndGZTBWWWZZMnI1SWtmWWdEKzBFVDNRa1JMbDA9</response>

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

2019-11-26 18:57:33 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:33 | [Mutex] received everything.

2019-11-26 18:57:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:33 | [Mutex] waiting for: [event]

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1VNWk4RGdpSDdVUk1ham5NYW5hNA==</auth>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VNWk4RGdpSDdVUk1ham5NYW5hNHYyYmtXdURvYkVuOGRndjYyZ1JYLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VTVpOERnaUg3VVJNYWpuTWFuYTR2MmJrV3VEb2JFbjhkZ3Y2MmdSWCxwPWcxTDJpOHNidUZEN0Rxc1hKTVBITjRYbG51RTR2RmtndlhkeE15Y3BEV009</response>

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

2019-11-26 18:57:33 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:33 | [Mutex] received everything.

2019-11-26 18:57:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:33 | [Mutex] waiting for: [event]

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1JZEl0RXBlcEhTUnZpYVh1enoyVQ==</auth>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JZEl0RXBlcEhTUnZpYVh1enoyVTRubDk3THl4UGkwbWlVZUUxRDN6LHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SWRJdEVwZXBIU1J2aWFYdXp6MlU0bmw5N0x5eFBpMG1pVWVFMUQzeixwPXFnV2lQUkVVSE03QTRBWW5WckVqS21LL0N3NnpjQzJZU0JGczdBZjMxRUE9</response>

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

2019-11-26 18:57:33 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:33 | [Mutex] received everything.

2019-11-26 18:57:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:33 | [Mutex] waiting for: [event]

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1nZnNSTkZuWEU4TTBCamh3VTZLdA==</auth>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nZnNSTkZuWEU4TTBCamh3VTZLdFpCc09aNFB1dTJPOFg4VmE0d1hvLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z2ZzUk5GblhFOE0wQmpod1U2S3RaQnNPWjRQdXUyTzhYOFZhNHdYbyxwPTF2YzFMZDk0aFpnbm5OcVNza00rYkhYZ1dRMUxkVElGTDFlTG1sSUFZZ0U9</response>

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

2019-11-26 18:57:33 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:33 | [Mutex] received everything.

2019-11-26 18:57:33 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:33 | [Mutex] waiting for: [event]

2019-11-26 18:57:33 | user :: user_wfz6uu0027@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-26 18:57:33 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:34 | user :: user_wfz6uu0027@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-26 18:57:34 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1PekJYck5BYzk2cWdVVno0UEQ0Qw==</auth>

2019-11-26 18:57:34 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PekJYck5BYzk2cWdVVno0UEQ0Q3ZpQ3pac1Y4Q3hESDRiUlJZTDNLLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:34 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T3pCWHJOQWM5NnFnVVZ6NFBENEN2aUN6WnNWOEN4REg0YlJSWUwzSyxwPWhtRGtheXByZXVPcjlITEF6anViQXV0L0lxWElQWkd0UUkweGZQQVVhRWs9</response>

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

2019-11-26 18:57:34 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:34 | [Mutex] notify: [event, disconnected]

2019-11-26 18:57:34 | [Mutex] received everything.

2019-11-26 18:57:34 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:34 | user :: user_wfz6uu0027@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-26 18:57:34 | user :: user_wfz6uu0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:34 | user :: user_wfz6uu0027@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-26 18:57:34 | user :: user_wfz6uu0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3dmejZ1dTAwMjcscj1UaDAxbEl1cm5LSWZ1WGFmSnh3YQ==</auth>

2019-11-26 18:57:34 | user :: user_wfz6uu0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UaDAxbEl1cm5LSWZ1WGFmSnh3YVhkUGdYNWR3c25MM25GVDdHQ0RqLHM9TkVzM1NjcmxKZnJuTHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:34 | user :: user_wfz6uu0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VGgwMWxJdXJuS0lmdVhhZkp4d2FYZFBnWDVkd3NuTDNuRlQ3R0NEaixwPTF0K0g4SzVpSjhrZXdWNThtQ3hxTkErK2l4em5ubk10RXdRVlo4RVN4VHc9</response>

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

2019-11-26 18:57:36 | [Mutex] waiting for: [user]

2019-11-26 18:57:36 | [Mutex] received everything.

2019-11-26 18:57:36 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-26 18:57:36 |

2019-11-26 18:57:36 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-26 18:57:36 | ------------------------------------

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@16d9c8f5

2019-11-26 18:57:36 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7270da70}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@181e345e}, 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@1c21a385}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59233e65}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@165dbd4}, 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=Tue Nov 26 18:57:36 PST 2019}}}}

2019-11-26 18:57:36 | [Mutex] waiting for: [registration]

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@68b0a362

2019-11-26 18:57:36 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@181e345e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@1c21a385}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59233e65}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@165dbd4}, 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=Tue Nov 26 18:57:36 PST 2019}}}}

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@791c187a

2019-11-26 18:57:36 | 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-26 18:57:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@390cc12a}

2019-11-26 18:57:36 | 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-26 18:57:36 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@169806a4

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7bde1ca6

2019-11-26 18:57:36 | 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-26 18:57:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6218146f}

2019-11-26 18:57:36 | 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-26 18:57:36 | user :: null >> <iq to="localhost" id="FKfHshMNQIx9iWSX00qj0ma" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-26 18:57:36 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f6853d46}

2019-11-26 18:57:36 | user :: null << <iq from="localhost" id="FKfHshMNQIx9iWSX00qj0ma" xmlns="jabber:client" type="result"><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-26 18:57:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3d429c97}

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6b3900bd

2019-11-26 18:57:36 | user :: null >> <iq to="localhost" id="CI7smW7iX8vgydv0mIDmIQ9" type="set"><query xmlns="jabber:iq:register"><username>user_rd7a550028</username><password>user_rd7a550028</password><email>85e9023b-92f3-4afc-9b8b-160a9eb7face@localhost</email></query></iq>

2019-11-26 18:57:36 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@be287adf}

2019-11-26 18:57:36 | user :: null << <iq from="localhost" id="CI7smW7iX8vgydv0mIDmIQ9" xmlns="jabber:client" type="result"/>

2019-11-26 18:57:36 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@60091a50}

2019-11-26 18:57:36 | [Mutex] received everything.

2019-11-26 18:57:36 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 18:57:36 | 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;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@390cc12a, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6218146f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@181e345e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@1c21a385}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59233e65}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@165dbd4}, 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=Tue Nov 26 18:57:36 PST 2019}}}}

2019-11-26 18:57:36 | 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;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@390cc12a, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6218146f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@181e345e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@1c21a385}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59233e65}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@165dbd4}, 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=Tue Nov 26 18:57:36 PST 2019}}}}

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4290c152

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6b9f4bb3

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@48008295

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@60f3ca5f

2019-11-26 18:57:36 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@24ad0d42

2019-11-26 18:57:36 | user :: user_rd7a550028@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-26 18:57:36 | user :: user_rd7a550028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:36 | user :: user_rd7a550028@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-26 18:57:36 | user :: user_rd7a550028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JkN2E1NTAwMjgscj1wY1U0NHFqRDc2N3VoTG5la3pmTA==</auth>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wY1U0NHFqRDc2N3VoTG5la3pmTEVlc0tIcDg3cXNmMXBsZWFCZTNOLHM9alZWN1BQb3BtczIwVXc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cGNVNDRxakQ3Njd1aExuZWt6ZkxFZXNLSHA4N3FzZjFwbGVhQmUzTixwPWJRaTBSWDMwTm9Ob0ZqYTgwOTB0ejBiNVFWaGg5aGlZbUVBTzhLSDg1eVE9</response>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj02NlhMUHhBbjUwSjYrbjNLL1JHM3JIOVphMjNOM2wyaHlGeENxMDhtVW1vPQ==</success>

2019-11-26 18:57:36 | user :: user_rd7a550028@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 hash="SHA-1" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost >> <iq xmlns="jabber:client" id="E0X6rWfIFAcv5aGmVWSaNYi" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost << <iq to="user_rd7a550028@localhost/993927746-tigase-20" id="E0X6rWfIFAcv5aGmVWSaNYi" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_rd7a550028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="6K9wucDk1gLMAhDgSKHuYmb" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost/993927746-tigase-20 << <iq to="user_rd7a550028@localhost/993927746-tigase-20" id="6K9wucDk1gLMAhDgSKHuYmb" xmlns="jabber:client" type="result"/>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost/993927746-tigase-20 >> <iq to="localhost" id="CLayykTQ3kT26jHo8gJy6CH" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost/993927746-tigase-20 << <enabled location="d4270859fb27" id="a3cb1810-421d-4d37-801b-b357942964e8" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost/993927746-tigase-20 >> <iq id="IYLIFAcv5aGmVWSaNYi2lLE" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:57:36 | user :: user_rd7a550028@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-26 18:57:36 | user :: user_rd7a550028@localhost/993927746-tigase-20 << <iq from="localhost" to="user_rd7a550028@localhost/993927746-tigase-20" id="CLayykTQ3kT26jHo8gJy6CH" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost/993927746-tigase-20 << <iq to="user_rd7a550028@localhost/993927746-tigase-20" id="IYLIFAcv5aGmVWSaNYi2lLE" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:57:36 | Disconnecting

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

2019-11-26 18:57:36 | [Mutex] notify: [disconnected]

2019-11-26 18:57:36 | [Mutex] received everything.

2019-11-26 18:57:36 | [Mutex] waiting for: [event]

2019-11-26 18:57:36 | user :: user_rd7a550028@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-26 18:57:36 | user :: user_rd7a550028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:36 | user :: user_rd7a550028@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-26 18:57:36 | user :: user_rd7a550028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JkN2E1NTAwMjgscj1rckZIVEJoRWdTTU9pVXllS1RJZg==</auth>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rckZIVEJoRWdTTU9pVXllS1RJZkFCbmVjNnJPRDAyWXF2ZGk3YW9uLHM9alZWN1BQb3BtczIwVXc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:36 | user :: user_rd7a550028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a3JGSFRCaEVnU01PaVV5ZUtUSWZBQm5lYzZyT0QwMllxdmRpN2FvbixwPW90MEVEemQvTldSRXNtSC80T3VKa0tRc3hEMFBIWDlzUTFuTExWVS85SUU9</response>

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

2019-11-26 18:57:36 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:36 | [Mutex] notify: [event, disconnected]

2019-11-26 18:57:36 | [Mutex] received everything.

2019-11-26 18:57:36 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:36 | [Mutex] waiting for: [event]

2019-11-26 18:57:36 | user :: user_rd7a550028@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-26 18:57:36 | user :: user_rd7a550028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:37 | user :: user_rd7a550028@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-26 18:57:37 | user :: user_rd7a550028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JkN2E1NTAwMjgscj1LVWJNdmQxdjI3T01nUlpNNnlWYg==</auth>

2019-11-26 18:57:37 | user :: user_rd7a550028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LVWJNdmQxdjI3T01nUlpNNnlWYjRISW81TG04dGRZQmx5SFNHRHdyLHM9alZWN1BQb3BtczIwVXc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:37 | user :: user_rd7a550028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S1ViTXZkMXYyN09NZ1JaTTZ5VmI0SElvNUxtOHRkWUJseUhTR0R3cixwPUxKOVBqY0tFSkVyclMwSi9iMHFkeGdxVjI3NTNiZzd0OGVEZHBacThta0k9</response>

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

2019-11-26 18:57:37 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:37 | [Mutex] received everything.

2019-11-26 18:57:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:37 | [Mutex] waiting for: [event]

2019-11-26 18:57:37 | user :: user_rd7a550028@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-26 18:57:37 | user :: user_rd7a550028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:37 | user :: user_rd7a550028@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-26 18:57:37 | user :: user_rd7a550028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JkN2E1NTAwMjgscj1INDRuZnU5Q3FrTzVDTGtPUnBzRA==</auth>

2019-11-26 18:57:37 | user :: user_rd7a550028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1INDRuZnU5Q3FrTzVDTGtPUnBzRG91SzdwZ1RCaWRJeElhVUtVYTY5LHM9alZWN1BQb3BtczIwVXc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:37 | user :: user_rd7a550028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SDQ0bmZ1OUNxa081Q0xrT1Jwc0RvdUs3cGdUQmlkSXhJYVVLVWE2OSxwPVRXM3hBelVWRVcxMUJKUzRPb2laTDdWSHRrS0llZHRJWjd4N2hCdGRHalE9</response>

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

2019-11-26 18:57:37 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:37 | [Mutex] notify: [event, disconnected]

2019-11-26 18:57:37 | [Mutex] received everything.

2019-11-26 18:57:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:37 | [Mutex] waiting for: [event]

2019-11-26 18:57:37 | user :: user_rd7a550028@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-26 18:57:37 | user :: user_rd7a550028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:37 | user :: user_rd7a550028@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-26 18:57:37 | user :: user_rd7a550028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JkN2E1NTAwMjgscj1HenVHUXBsSTZXSmdaMHhmTUJUaA==</auth>

2019-11-26 18:57:37 | user :: user_rd7a550028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HenVHUXBsSTZXSmdaMHhmTUJUaDdWdk5OZ0lYOTY0a1d1VW85dXdZLHM9alZWN1BQb3BtczIwVXc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:37 | user :: user_rd7a550028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R3p1R1FwbEk2V0pnWjB4Zk1CVGg3VnZOTmdJWDk2NGtXdVVvOXV3WSxwPVFhdnpLaCtSbEk2Zmh0bVRadkVOOXZhbkhGYTRhUFJWZGIySVVkdS82YkE9</response>

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

2019-11-26 18:57:37 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:37 | [Mutex] received everything.

2019-11-26 18:57:37 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:37 | user :: user_rd7a550028@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-26 18:57:37 | user :: user_rd7a550028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:37 | user :: user_rd7a550028@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-26 18:57:37 | user :: user_rd7a550028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3JkN2E1NTAwMjgscj1GbG02cTVvVXlqYm85VXR6UHFYNw==</auth>

2019-11-26 18:57:37 | user :: user_rd7a550028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GbG02cTVvVXlqYm85VXR6UHFYN2taZjh3VTRycmFoa2huZ0ZKRVhGLHM9alZWN1BQb3BtczIwVXc9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:37 | user :: user_rd7a550028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RmxtNnE1b1V5amJvOVV0elBxWDdrWmY4d1U0cnJhaGtobmdGSkVYRixwPUpFK0lqbHByT3JxSlg4SWhWNWpSSXl1OERxWVRpalRSZ3B2RW44MWNyL1k9</response>

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

2019-11-26 18:57:39 | [Mutex] waiting for: [user]

2019-11-26 18:57:39 | [Mutex] received everything.

2019-11-26 18:57:39 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-26 18:57:39 |

2019-11-26 18:57:39 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-26 18:57:39 | ------------------------------------

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@129595c1

2019-11-26 18:57:39 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7270da70}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1c5269e3}, 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@186dfeb1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5d6f63d8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@63eade29}, 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=Tue Nov 26 18:57:39 PST 2019}}}}

2019-11-26 18:57:39 | [Mutex] waiting for: [registration]

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6cf8bec6

2019-11-26 18:57:39 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1c5269e3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@186dfeb1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5d6f63d8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@63eade29}, 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=Tue Nov 26 18:57:39 PST 2019}}}}

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@1b975d9e

2019-11-26 18:57:39 | 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-26 18:57:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3d409c97}

2019-11-26 18:57:39 | 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-26 18:57:39 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@86e1680

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@21c997c5

2019-11-26 18:57:39 | 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-26 18:57:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@9355cf}

2019-11-26 18:57:39 | 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-26 18:57:39 | user :: null >> <iq to="localhost" id="TKZWi3uk6t1aMR3bAlWkSZ2" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-26 18:57:39 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d8032bb2}

2019-11-26 18:57:39 | user :: null << <iq from="localhost" id="TKZWi3uk6t1aMR3bAlWkSZ2" xmlns="jabber:client" type="result"><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-26 18:57:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@390ec56e}

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@41ac1ed9

2019-11-26 18:57:39 | user :: null >> <iq to="localhost" id="Y1MYdv8IJNFyhO4mXYjQV6e" type="set"><query xmlns="jabber:iq:register"><username>user_341nkm0029</username><password>user_341nkm0029</password><email>ceeee65f-c326-4e85-a654-4cf957929e5a@localhost</email></query></iq>

2019-11-26 18:57:39 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6dc32956}

2019-11-26 18:57:39 | user :: null << <iq from="localhost" id="Y1MYdv8IJNFyhO4mXYjQV6e" xmlns="jabber:client" type="result"/>

2019-11-26 18:57:39 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2c36ce96}

2019-11-26 18:57:39 | [Mutex] received everything.

2019-11-26 18:57:39 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 18:57:39 | 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;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3d409c97, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@9355cf]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1c5269e3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@186dfeb1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5d6f63d8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@63eade29}, 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=Tue Nov 26 18:57:39 PST 2019}}}}

2019-11-26 18:57:39 | 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;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3d409c97, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@9355cf]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1c5269e3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@186dfeb1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5d6f63d8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@63eade29}, 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=Tue Nov 26 18:57:39 PST 2019}}}}

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3611dbf2

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@79fb4deb

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5800dedb

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@42d8e933

2019-11-26 18:57:39 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@7aae74d1

2019-11-26 18:57:39 | user :: user_341nkm0029@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-26 18:57:39 | user :: user_341nkm0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:39 | user :: user_341nkm0029@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-26 18:57:39 | user :: user_341nkm0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzM0MW5rbTAwMjkscj1jeW9GNWtqdEt3bWJ4NXY4b0J2dA==</auth>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jeW9GNWtqdEt3bWJ4NXY4b0J2dHl2cFcxQUJRR0F3YW5selpHZkZmLHM9Q0FRMVZkNStDd2hFM3c9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y3lvRjVranRLd21ieDV2OG9CdnR5dnBXMUFCUUdBd2FubHpaR2ZGZixwPTRBakhuUDVHb1pBQVFOZ2tWU0FJdFZndUFDMDVFUWFRNVJSMkRQalRZajg9</response>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1oSEd2eWpBVUdiUEVLV2d1cmtXeWF4bXUxNnZJdjhMREh5VTJ6WkZCVWUwPQ==</success>

2019-11-26 18:57:39 | user :: user_341nkm0029@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 hash="SHA-1" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost >> <iq xmlns="jabber:client" id="CRgKW6rWfIFAcv5aGmVWSaN" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost << <iq to="user_341nkm0029@localhost/993927746-tigase-21" id="CRgKW6rWfIFAcv5aGmVWSaN" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_341nkm0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="32LzmT2wgLAxiPUQNFk00dw" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost/993927746-tigase-21 << <iq to="user_341nkm0029@localhost/993927746-tigase-21" id="32LzmT2wgLAxiPUQNFk00dw" xmlns="jabber:client" type="result"/>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="hP6fukEv6cO5ysmZ3eU7zdE" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost/993927746-tigase-21 >> <iq id="xb8xpT0bCGApS7s9y8nPEEi" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost/993927746-tigase-21 << <enabled location="d4270859fb27" id="16977608-2611-4814-8124-6db0cf825cd7" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2019-11-26 18:57:39 | user :: user_341nkm0029@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-26 18:57:39 | user :: user_341nkm0029@localhost/993927746-tigase-21 << <iq from="localhost" to="user_341nkm0029@localhost/993927746-tigase-21" id="hP6fukEv6cO5ysmZ3eU7zdE" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost/993927746-tigase-21 << <iq to="user_341nkm0029@localhost/993927746-tigase-21" id="xb8xpT0bCGApS7s9y8nPEEi" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:57:39 | Disconnecting

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

2019-11-26 18:57:39 | [Mutex] notify: [disconnected]

2019-11-26 18:57:39 | [Mutex] received everything.

2019-11-26 18:57:39 | [Mutex] waiting for: [event]

2019-11-26 18:57:39 | user :: user_341nkm0029@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-26 18:57:39 | user :: user_341nkm0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:39 | user :: user_341nkm0029@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-26 18:57:39 | user :: user_341nkm0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzM0MW5rbTAwMjkscj15SnJNT3pobWxIOFhZZjRVazZ0NA==</auth>

2019-11-26 18:57:39 | user :: user_341nkm0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15SnJNT3pobWxIOFhZZjRVazZ0NHI2azVtYnAySm5BSDdPMTl2eFFpLHM9Q0FRMVZkNStDd2hFM3c9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:40 | user :: user_341nkm0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eUpyTU96aG1sSDhYWWY0VWs2dDRyNms1bWJwMkpuQUg3TzE5dnhRaSxwPUdnWWR0TTc0L3A4OTNkeFlsRlRZYjgxQUwwUzdBejdqMVBiMUxwVGxNUmM9</response>

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

2019-11-26 18:57:40 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:40 | [Mutex] received everything.

2019-11-26 18:57:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:40 | [Mutex] waiting for: [event]

2019-11-26 18:57:40 | user :: user_341nkm0029@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-26 18:57:40 | user :: user_341nkm0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:40 | user :: user_341nkm0029@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-26 18:57:40 | user :: user_341nkm0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzM0MW5rbTAwMjkscj1MWUZiUXpGQUJxaFhSR2dLT2ZFMA==</auth>

2019-11-26 18:57:40 | user :: user_341nkm0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MWUZiUXpGQUJxaFhSR2dLT2ZFMExJSVN4WXZ4dHd2b2xrdTRreFdpLHM9Q0FRMVZkNStDd2hFM3c9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:40 | user :: user_341nkm0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TFlGYlF6RkFCcWhYUkdnS09mRTBMSUlTeFl2eHR3dm9sa3U0a3hXaSxwPW9SbEVtOXNxeDV3T1o5VE45SWQvUjFiRm5KZTdnN21Sdzg1OS9maytPYTg9</response>

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

2019-11-26 18:57:40 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:40 | [Mutex] received everything.

2019-11-26 18:57:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:40 | [Mutex] waiting for: [event]

2019-11-26 18:57:40 | user :: user_341nkm0029@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-26 18:57:40 | user :: user_341nkm0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:40 | user :: user_341nkm0029@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-26 18:57:40 | user :: user_341nkm0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfMzQxbmttMDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-26 18:57:40 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:40 | [Mutex] received everything.

2019-11-26 18:57:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:40 | [Mutex] waiting for: [event]

2019-11-26 18:57:40 | user :: user_341nkm0029@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-26 18:57:40 | user :: user_341nkm0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:40 | user :: user_341nkm0029@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-26 18:57:40 | user :: user_341nkm0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfMzQxbmttMDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-26 18:57:40 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:40 | [Mutex] received everything.

2019-11-26 18:57:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:40 | user :: user_341nkm0029@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-26 18:57:40 | user :: user_341nkm0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:40 | user :: user_341nkm0029@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-26 18:57:40 | user :: user_341nkm0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzM0MW5rbTAwMjkscj1TZGlGaWlpNVpxV1BBcDE1WnVXYg==</auth>

2019-11-26 18:57:40 | user :: user_341nkm0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TZGlGaWlpNVpxV1BBcDE1WnVXYm4xV1N2Z0RIM0dCeUhpUVBGN0JZLHM9Q0FRMVZkNStDd2hFM3c9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:40 | user :: user_341nkm0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U2RpRmlpaTVacVdQQXAxNVp1V2JuMVdTdmdESDNHQnlIaVFQRjdCWSxwPWNUQXFrZEJsQ1FNNnJsOXY1aUtyZlV4bVVWOVdKbWVsVExDa3QvLzh0OWc9</response>

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

2019-11-26 18:57:42 | [Mutex] waiting for: [user]

2019-11-26 18:57:42 | [Mutex] received everything.

2019-11-26 18:57:42 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-26 18:57:42 |

2019-11-26 18:57:42 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-26 18:57:42 | ------------------------------------

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@62a737cf

2019-11-26 18:57:42 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7270da70}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6c60c5eb}, 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@685f5cbf}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2d5dcfd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@761f8cfb}, 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=Tue Nov 26 18:57:42 PST 2019}}}}

2019-11-26 18:57:42 | [Mutex] waiting for: [registration]

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1cba404e

2019-11-26 18:57:42 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6c60c5eb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@685f5cbf}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2d5dcfd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@761f8cfb}, 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=Tue Nov 26 18:57:42 PST 2019}}}}

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@e125dc2

2019-11-26 18:57:42 | 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-26 18:57:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4d72309f}

2019-11-26 18:57:42 | 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-26 18:57:42 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4700159e

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@9769500

2019-11-26 18:57:42 | 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-26 18:57:42 | 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-26 18:57:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@151635a1}

2019-11-26 18:57:42 | user :: null >> <iq to="localhost" id="SZsYWi3uk6t1aMR3bAlWkSZ" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-26 18:57:42 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@23aad496}

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@493c0954

2019-11-26 18:57:42 | user :: null << <iq from="localhost" id="SZsYWi3uk6t1aMR3bAlWkSZ" xmlns="jabber:client" type="result"><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-26 18:57:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ed75908}

2019-11-26 18:57:42 | user :: null >> <iq to="localhost" id="Q9UMLCeSdOYo3buq9DlUZeU" type="set"><query xmlns="jabber:iq:register"><username>user_qegcih0030</username><password>user_qegcih0030</password><email>862d32c8-688a-46b3-b38f-1ed92e41a2a7@localhost</email></query></iq>

2019-11-26 18:57:42 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@69746d8}

2019-11-26 18:57:42 | user :: null << <iq from="localhost" id="Q9UMLCeSdOYo3buq9DlUZeU" xmlns="jabber:client" type="result"/>

2019-11-26 18:57:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@33340347}

2019-11-26 18:57:42 | [Mutex] received everything.

2019-11-26 18:57:42 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 18:57:42 | 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;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4d72309f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@151635a1]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6c60c5eb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@685f5cbf}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2d5dcfd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@761f8cfb}, 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=Tue Nov 26 18:57:42 PST 2019}}}}

2019-11-26 18:57:42 | 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;@7270da70}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4d72309f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@151635a1]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6c60c5eb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@334dd04b}, 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@685f5cbf}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2d5dcfd0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@761f8cfb}, 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=Tue Nov 26 18:57:42 PST 2019}}}}

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@172b93bd

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@3e744ea5

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@a5f4f7a

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@19625b4d

2019-11-26 18:57:42 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@529f95a7

2019-11-26 18:57:42 | user :: user_qegcih0030@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-26 18:57:42 | user :: user_qegcih0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:42 | user :: user_qegcih0030@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-26 18:57:42 | user :: user_qegcih0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3FlZ2NpaDAwMzAscj1DRUtENkNGRlE1cE1VVDExQkc3VA==</auth>

2019-11-26 18:57:42 | user :: user_qegcih0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DRUtENkNGRlE1cE1VVDExQkc3VE9qRUQyYU9lOEVDaTNsUTJzTzBuLHM9d0pXK3RkSThnSmp1UUE9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:42 | user :: user_qegcih0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q0VLRDZDRkZRNXBNVVQxMUJHN1RPakVEMmFPZThFQ2kzbFEyc08wbixwPWk3MVdtdWRId241TVdENW44UXJmZnc5WEZQeFUrZTQ5UEc5LzdrYUppNEU9</response>

2019-11-26 18:57:42 | user :: user_qegcih0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1oaTVUN3kxNUU1cnRWL3dMY1cwZlIycDY0a3E4ZTFnQnRrc2I4L2c0Q3FNPQ==</success>

2019-11-26 18:57:42 | user :: user_qegcih0030@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 hash="SHA-1" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-26 18:57:42 | user :: user_qegcih0030@localhost >> <iq xmlns="jabber:client" id="B2xdGOQVUbAp4arXUakROCE" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-26 18:57:42 | user :: user_qegcih0030@localhost/993927746-tigase-22 << <iq to="user_qegcih0030@localhost/993927746-tigase-22" id="sbWiRNIS3rX8r8IEx8DudGo" xmlns="jabber:client" type="result"/>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="D6FKIFo9whOEpTMUOPKuofS" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-22 << <iq from="localhost" to="user_qegcih0030@localhost/993927746-tigase-22" id="D6FKIFo9whOEpTMUOPKuofS" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-22 << <enabled location="d4270859fb27" id="72812aeb-f5da-418e-952e-575de869015e" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-22 >> <iq id="URUcR6yynPM0jXZczoeGBgT" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:57:43 | user :: user_qegcih0030@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-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-22 << <iq to="user_qegcih0030@localhost/993927746-tigase-22" id="URUcR6yynPM0jXZczoeGBgT" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:57:43 | Disconnecting

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

2019-11-26 18:57:43 | [Mutex] notify: [disconnected]

2019-11-26 18:57:43 | [Mutex] received everything.

2019-11-26 18:57:43 | [Mutex] waiting for: [event]

2019-11-26 18:57:43 | user :: user_qegcih0030@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-26 18:57:43 | user :: user_qegcih0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:43 | user :: user_qegcih0030@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-26 18:57:43 | user :: user_qegcih0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3FlZ2NpaDAwMzAscj1ERlJ6cVdwVkV4UVNoTFp4dEJmdA==</auth>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ERlJ6cVdwVkV4UVNoTFp4dEJmdFhoZjJUdWRxOExnUWhSSWtRWktBLHM9d0pXK3RkSThnSmp1UUE9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9REZSenFXcFZFeFFTaExaeHRCZnRYaGYyVHVkcThMZ1FoUklrUVpLQSxwPVR6d3d2clZBSEtsUy9OQ3UrRzl3S08yWUpFVEphSkwrRlVGd1IzT0p5RFE9</response>

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

2019-11-26 18:57:43 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:43 | [Mutex] received everything.

2019-11-26 18:57:43 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:43 | [Mutex] waiting for: [event]

2019-11-26 18:57:43 | user :: user_qegcih0030@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-26 18:57:43 | user :: user_qegcih0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:43 | user :: user_qegcih0030@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-26 18:57:43 | user :: user_qegcih0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3FlZ2NpaDAwMzAscj1RYjdrSWtBd1FjcEIyWklNOVlabA==</auth>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RYjdrSWtBd1FjcEIyWklNOVlabENRcUswNHJvdjVxRFBXUGFSWmlTLHM9d0pXK3RkSThnSmp1UUE9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UWI3a0lrQXdRY3BCMlpJTTlZWmxDUXFLMDRyb3Y1cURQV1BhUlppUyxwPW96ZC82ZEM1WEFuZUZDeVl1a2NOQmxsTDFMNStVRGVCcHV0bjRVYUxRZ0E9</response>

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

2019-11-26 18:57:43 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:43 | [Mutex] received everything.

2019-11-26 18:57:43 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:43 | [Mutex] waiting for: [event]

2019-11-26 18:57:43 | user :: user_qegcih0030@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-26 18:57:43 | user :: user_qegcih0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:43 | user :: user_qegcih0030@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-26 18:57:43 | user :: user_qegcih0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3FlZ2NpaDAwMzAscj1iaE9UY21xMzMzdWxMNmNySzlDYw==</auth>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iaE9UY21xMzMzdWxMNmNySzlDY2Njb0V3STJ3VnVkbVJqdnZIOGs0LHM9d0pXK3RkSThnSmp1UUE9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YmhPVGNtcTMzM3VsTDZjcks5Q2NjY29Fd0kyd1Z1ZG1SanZ2SDhrNCxwPWVIbG1ZcjhJQjlPakxaMEpRTU45YXlpanJpdHdPUUlaTE12am9NZGdWSFk9</response>

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

2019-11-26 18:57:43 | [Mutex] notify: [event, authFailed]

2019-11-26 18:57:43 | [Mutex] received everything.

2019-11-26 18:57:43 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:57:43 | user :: user_qegcih0030@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-26 18:57:43 | user :: user_qegcih0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-26 18:57:43 | user :: user_qegcih0030@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-26 18:57:43 | user :: user_qegcih0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3FlZ2NpaDAwMzAscj1kaUJKWWNwa293N3laM0ZlWVc3NA==</auth>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kaUJKWWNwa293N3laM0ZlWVc3NG9lekFIRnJtMFdyM1FldXlhQkFzLHM9d0pXK3RkSThnSmp1UUE9PSxpPTQwOTY=</challenge>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZGlCSlljcGtvdzd5WjNGZVlXNzRvZXpBSEZybTBXcjNRZXV5YUJBcyxwPTRJdTVvS2p4ZW13UkRCbXNoczcyWHJBQ00zQ2ppalZEd0tKVDU4cXFmWUE9</response>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1iVUc0eEJqNFlVTW00RkdCcFJhd3ZOR2p3SUJVdlZpNlNUbVQ1M1VtRXpzPQ==</success>

2019-11-26 18:57:43 | user :: user_qegcih0030@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 hash="SHA-1" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost >> <iq xmlns="jabber:client" id="If2gLMAhDgSKHuYmbKQ8x9q" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost << <iq to="user_qegcih0030@localhost/993927746-tigase-23" id="If2gLMAhDgSKHuYmbKQ8x9q" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_qegcih0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="jTWcoZ48GP2qiRNIS3rX8r8" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-23 << <iq to="user_qegcih0030@localhost/993927746-tigase-23" id="jTWcoZ48GP2qiRNIS3rX8r8" xmlns="jabber:client" type="result"/>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="w2l6vlLKFACs9m5o1iClLwo" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-23 >> <iq id="59Er8IEx8DudGoTRIMyjIqg" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-23 << <enabled location="d4270859fb27" id="ee601de1-1e6f-4b75-a07f-556192af7a68" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2019-11-26 18:57:43 | user :: user_qegcih0030@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-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-23 << <iq from="localhost" to="user_qegcih0030@localhost/993927746-tigase-23" id="w2l6vlLKFACs9m5o1iClLwo" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-11-26 18:57:43 | user :: user_qegcih0030@localhost/993927746-tigase-23 << <iq to="user_qegcih0030@localhost/993927746-tigase-23" id="59Er8IEx8DudGoTRIMyjIqg" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:57:43 | Disconnecting

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

2019-11-26 18:57:43 | [Mutex] notify: [disconnected]

2019-11-26 18:57:43 | [Mutex] received everything.

2019-11-26 18:57:45 | [Mutex] waiting for: [user]

2019-11-26 18:57:45 | [Mutex] received everything.

2019-11-26 18:57:45 | [Mutex] isItemNotified: user:ok:true :: true