Brute Force Prevention

2019-11-25 20:30:37 |

2019-11-25 20:30:37 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 20:30:37 | ------------------------------------

2019-11-25 20:30:37 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3905f8c2

2019-11-25 20:30:37 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@26e5b780}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37c20192}, 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@33fd93b2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76ff0ba9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@602a3e5c}, 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=Mon Nov 25 20:30:37 PST 2019}}}}

2019-11-25 20:30:37 | [Mutex] waiting for: [registration]

2019-11-25 20:30:37 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@47437d5a

2019-11-25 20:30:37 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37c20192}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@33fd93b2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76ff0ba9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@602a3e5c}, 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=Mon Nov 25 20:30:37 PST 2019}}}}

2019-11-25 20:30:37 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@187c1603

2019-11-25 20:30:37 | 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-25 20:30:37 | 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-25 20:30:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@16d0f4e6}

2019-11-25 20:30:37 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:37 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-25 20:30:37 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@27b9f0be

2019-11-25 20:30:37 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@7b4ce0be

2019-11-25 20:30:37 | 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-25 20:30:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3783dda}

2019-11-25 20:30:37 | 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-25 20:30:37 | user :: null >> <iq to="localhost" id="JzYVcKzq7hT17DjO7zt8KIw" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 20:30:37 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5ef6f142}

2019-11-25 20:30:37 | user :: null << <iq id="JzYVcKzq7hT17DjO7zt8KIw" xmlns="jabber:client" from="localhost" 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-25 20:30:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@129e8e97}

2019-11-25 20:30:37 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@7acaa07a

2019-11-25 20:30:37 | user :: null >> <iq to="localhost" id="XUXdLIU2aIEuesYevv2kPFG" type="set"><query xmlns="jabber:iq:register"><username>user_w1nosj0027</username><password>user_w1nosj0027</password><email>39657212-c45e-40a9-920b-ec04b38194fc@localhost</email></query></iq>

2019-11-25 20:30:37 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@69094a04}

2019-11-25 20:30:38 | [Mutex] received everything.

2019-11-25 20:30:38 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 20:30:38 | user :: null << <iq id="XUXdLIU2aIEuesYevv2kPFG" xmlns="jabber:client" from="localhost" type="result"/>

2019-11-25 20:30:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@661fe68d}

2019-11-25 20:30:38 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@16d0f4e6, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3783dda]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37c20192}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@33fd93b2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76ff0ba9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@602a3e5c}, 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=Mon Nov 25 20:30:38 PST 2019}}}}

2019-11-25 20:30:38 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@16d0f4e6, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3783dda]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37c20192}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@33fd93b2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76ff0ba9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@602a3e5c}, 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=Mon Nov 25 20:30:38 PST 2019}}}}

2019-11-25 20:30:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@244b9179

2019-11-25 20:30:38 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@42c75951

2019-11-25 20:30:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6da1f803

2019-11-25 20:30:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@741350b4

2019-11-25 20:30:38 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@c2bd716

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj14Q0pnWU5iMnZMaU9KZGRWcWo3eA==</auth>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14Q0pnWU5iMnZMaU9KZGRWcWo3eGpJNktwR0c4ZndPbXpaVW1YNWJKLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eENKZ1lOYjJ2TGlPSmRkVnFqN3hqSTZLcEdHOGZ3T216WlVtWDViSixwPXdyOGZjZ3V0T0t3VTJGV0hpVFFDL3FFaXY5K2Rpd2dlRUJHb1NldC9HcDA9</response>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1hK0drK2M2QWI4OExhaDZ6VjJhaUZXMm9Gc0NxNE1rMDVTdk03Z0J5SFljPQ==</success>

2019-11-25 20:30:38 | user :: user_w1nosj0027@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 xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" hash="SHA-1"/></features>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost >> <iq xmlns="jabber:client" id="jHiBxjHNDsp9Dso06AoYcoQ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <iq id="jHiBxjHNDsp9Dso06AoYcoQ" xmlns="jabber:client" type="result" to="user_w1nosj0027@localhost/993927746-tigase-19"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_w1nosj0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="TwJPHAFFFwwgCCs6sUS27Ju" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost/993927746-tigase-19 << <iq id="TwJPHAFFFwwgCCs6sUS27Ju" xmlns="jabber:client" type="result" to="user_w1nosj0027@localhost/993927746-tigase-19"/>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="OKnZ1nZ3v3i5vlSeGsiOOSK" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost/993927746-tigase-19 << <enabled id="54ed425a-2181-4933-9276-fec068126d6a" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60" resume="true"/>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost/993927746-tigase-19 >> <iq id="FwFNCu9jYiFCv3r7j15mdLR" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost/993927746-tigase-19 << <iq id="FwFNCu9jYiFCv3r7j15mdLR" xmlns="jabber:client" type="result" to="user_w1nosj0027@localhost/993927746-tigase-19"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:30:38 | Disconnecting

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

2019-11-25 20:30:38 | [Mutex] notify: [disconnected]

2019-11-25 20:30:38 | [Mutex] received everything.

2019-11-25 20:30:38 | [Mutex] waiting for: [event]

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1mQlF1M29SckJweGoyUUExNmlSWg==</auth>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mQlF1M29SckJweGoyUUExNmlSWkdRNVJjNUNmc1lRZnNKdEZUS0xrLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZkJRdTNvUnJCcHhqMlFBMTZpUlpHUTVSYzVDZnNZUWZzSnRGVEtMayxwPXNGbE80bEc5TktDY1cxcTZZWXd2M2RaMnJRdkJ5cURwZDdyZnJUdUNrcnc9</response>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:38 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:38 | [Mutex] received everything.

2019-11-25 20:30:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:38 | [Mutex] waiting for: [event]

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj02VnRKQXhFTzhtem1Gekd1Umg2UQ==</auth>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02VnRKQXhFTzhtem1Gekd1Umg2UTB6eUhaQWdaTUkzQkJUQU5kRGtHLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NlZ0SkF4RU84bXptRnpHdVJoNlEwenlIWkFnWk1JM0JCVEFOZERrRyxwPTNpRUdzQnVWdlZCeUptZWM1UVdCKzZWVE5MODBZbzVOL2MzOW9OU2NBUEk9</response>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:38 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:38 | [Mutex] notify: [event, disconnected]

2019-11-25 20:30:38 | [Mutex] received everything.

2019-11-25 20:30:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:38 | [Mutex] waiting for: [event]

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj16QVhkSGtiQUhJS0Y3MXNHWEVhZw==</auth>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16QVhkSGtiQUhJS0Y3MXNHWEVhZ1ZadWsxMmUxYkNDRXVMZUZTUDJyLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ekFYZEhrYkFISUtGNzFzR1hFYWdWWnVrMTJlMWJDQ0V1TGVGU1AycixwPXBvNC9tUkJDRTlNTkNaeUJ6MDlKV1Zzb2ZmbDdkZmNhN2F6VnBTdGgrU0k9</response>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:38 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:38 | [Mutex] received everything.

2019-11-25 20:30:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:38 | [Mutex] waiting for: [event]

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1VcVJLWG9jZE4wZ1BZeUhUbTdwRA==</auth>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VcVJLWG9jZE4wZ1BZeUhUbTdwREtiVkZBd1ZHREdBbDljYlJvenpjLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VXFSS1hvY2ROMGdQWXlIVG03cERLYlZGQXdWR0RHQWw5Y2JSb3p6YyxwPUlYc3J4RW1yWEsyanR2Wk1YVC8xeWdGSjJEK3BXdStQaU5LdUlvbkpQK0U9</response>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:38 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:38 | [Mutex] received everything.

2019-11-25 20:30:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:38 | [Mutex] waiting for: [event]

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1MRXRwRVBXT3l2bFRCbU9DU2hRZA==</auth>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MRXRwRVBXT3l2bFRCbU9DU2hRZHhVcUtmdmRVUTJrd2w4Zmp4dHg1LHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TEV0cEVQV095dmxUQm1PQ1NoUWR4VXFLZnZkVVEya3dsOGZqeHR4NSxwPUNrb2s5MlpoRjBNaGlVeGpTaHo4TDM4ayt5dzdQSzkzSlVxWWs4bWhFSkE9</response>

2019-11-25 20:30:38 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:38 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:38 | [Mutex] received everything.

2019-11-25 20:30:38 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:38 | [Mutex] waiting for: [event]

2019-11-25 20:30:38 | user :: user_w1nosj0027@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-25 20:30:38 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1VeWxvNFozR25UR0RnS3hhQklmMA==</auth>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VeWxvNFozR25UR0RnS3hhQklmMExweDdIMXdqVW1wRTA1NENJaTdpLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VXlsbzRaM0duVEdEZ0t4YUJJZjBMcHg3SDF3alVtcEUwNTRDSWk3aSxwPWZCelFxT0JRNm9HNnFEdEczZ2VpWDBhM0pZUGlUOTZHTE5QT2VmdHZLWHc9</response>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:39 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:39 | [Mutex] received everything.

2019-11-25 20:30:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:39 | [Mutex] waiting for: [event]

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1sMmFHZVRIb0twQ2dIT0xySTQ5VA==</auth>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sMmFHZVRIb0twQ2dIT0xySTQ5VHFLNU9QaHJOd2dIU2RuZ296Njd4LHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bDJhR2VUSG9LcENnSE9Mckk0OVRxSzVPUGhyTndnSFNkbmdvejY3eCxwPTR3L1JFSHE0YklmUk11bjMrYkxQbFRyYlFma0VKVFQycDJLTkxQQSt6QWc9</response>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:39 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:39 | [Mutex] received everything.

2019-11-25 20:30:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:39 | [Mutex] waiting for: [event]

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj15ZGhVc3hEWEVpUHdSV3ZuUWtyTw==</auth>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15ZGhVc3hEWEVpUHdSV3ZuUWtyT01MUVV6ZE1VMXVQV2M0eFR1NnZZLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eWRoVXN4RFhFaVB3Uld2blFrck9NTFFVemRNVTF1UFdjNHhUdTZ2WSxwPWFpQWVPMkNtWXFFb1V2cUpXeHY0bytaaHducXZTcXNiYVZoWmZzTVdycHM9</response>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:39 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:39 | [Mutex] received everything.

2019-11-25 20:30:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:39 | [Mutex] waiting for: [event]

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1YY1ZQa1k5Q21ST2xnZUp5MUZoTw==</auth>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YY1ZQa1k5Q21ST2xnZUp5MUZoT290NUlYUE9lbDNRTENVU2ViOWdFLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WGNWUGtZOUNtUk9sZ2VKeTFGaE9vdDVJWFBPZWwzUUxDVVNlYjlnRSxwPW1sbnh3RUlZTFFQZDdpeldHMWYxckFBcmhjcHV2dzRzYXJaNDlsd2QySUE9</response>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:39 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:39 | [Mutex] received everything.

2019-11-25 20:30:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:39 | [Mutex] waiting for: [event]

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1OMnlkZWNEaUx6V3pkUDV6aURhVQ==</auth>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OMnlkZWNEaUx6V3pkUDV6aURhVXV1V2p6d1E1U0pRNTIxSEI4V3VXLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TjJ5ZGVjRGlMeld6ZFA1emlEYVV1dVdqendRNVNKUTUyMUhCOFd1VyxwPWpydEE4OFNlaXhkek1TN2dDZmRNR2JBSGgrMERMd2dvMnNWVzY5aGdEM2M9</response>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:39 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:39 | [Mutex] received everything.

2019-11-25 20:30:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:39 | [Mutex] waiting for: [event]

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1xNmZ5c2JKcXpoT1VwajlOR3huOA==</auth>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xNmZ5c2JKcXpoT1VwajlOR3huOHlWVmdUQnJUbHVXUm90bTJ3U1A4LHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cTZmeXNiSnF6aE9VcGo5Tkd4bjh5VlZnVEJyVGx1V1JvdG0yd1NQOCxwPThmbUgrWWNWa0puZ1NoejRsdFNNTXlQYnVidzZDRVQwQUk1WDBDOXFyUEk9</response>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:39 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:39 | [Mutex] received everything.

2019-11-25 20:30:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:39 | [Mutex] waiting for: [event]

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1BV1VDQmRnREdUYlB2Z01xbnpzNw==</auth>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BV1VDQmRnREdUYlB2Z01xbnpzN1oxUVIzU3lHWHQ4VzZXNVJoaFhELHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QVdVQ0JkZ0RHVGJQdmdNcW56czdaMVFSM1N5R1h0OFc2VzVSaGhYRCxwPVZGN3R3TE5TajVZdjhqZHlhcXlGeWp5djlrRHp2Znk2Nmg2ZEhWR1ZsMXM9</response>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:39 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:39 | [Mutex] received everything.

2019-11-25 20:30:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:39 | [Mutex] waiting for: [event]

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1QSEJnUjlQTTl3WlA2cEpOaEltVg==</auth>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QSEJnUjlQTTl3WlA2cEpOaEltVnhPaFZKdWh6bzVwanJuT21IWlh6LHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UEhCZ1I5UE05d1pQNnBKTmhJbVZ4T2hWSnVoem81cGpybk9tSFpYeixwPTVWNDhwYjh2U3h1MlFTOVd6eFlzR2N1YlRCdXdYZ3RWUnFzRFVzU1dJTFk9</response>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:39 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:39 | [Mutex] received everything.

2019-11-25 20:30:39 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:39 | [Mutex] waiting for: [event]

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:39 | user :: user_w1nosj0027@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-25 20:30:39 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj00NlNnOTBLeFRzYlVSU3FPNnJPTw==</auth>

2019-11-25 20:30:39 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00NlNnOTBLeFRzYlVSU3FPNnJPTzlPQjZ5R2ZuZzZhR242Y2dhRXN0LHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NDZTZzkwS3hUc2JVUlNxTzZyT085T0I2eUdmbmc2YUduNmNnYUVzdCxwPS9BRUlIWnF0ejQ4S0VyTmpwblZwWUZXcnRRTENqdW1wOEZaUlhRTUlFelk9</response>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:40 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:40 | [Mutex] received everything.

2019-11-25 20:30:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:40 | [Mutex] waiting for: [event]

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj03djNaekJJMmlMVEFwbjhFN1djVg==</auth>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03djNaekJJMmlMVEFwbjhFN1djVlluUHNzQzlHTXhCdDdBT3A1aDVDLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N3YzWnpCSTJpTFRBcG44RTdXY1ZZblBzc0M5R014QnQ3QU9wNWg1QyxwPStIR1QzYVNPbE5oc2lhWFJLM2xqV0NyV1VjU1VvdHdmaXdTa0hLdmFVbWc9</response>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:40 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:40 | [Mutex] received everything.

2019-11-25 20:30:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:40 | [Mutex] waiting for: [event]

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj15WWNDUDdweVhMQVBYZFNpOEdydg==</auth>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15WWNDUDdweVhMQVBYZFNpOEdydjV3SmliV1I3cEZ4YVV5NzQxRGI1LHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eVljQ1A3cHlYTEFQWGRTaThHcnY1d0ppYldSN3BGeGFVeTc0MURiNSxwPTdyNitzcmlkVXAyNDFzSjRVSURrU3RmaXM1OWFhQ28vamlwbTljZ1J5RFk9</response>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:40 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:40 | [Mutex] received everything.

2019-11-25 20:30:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:40 | [Mutex] waiting for: [event]

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1Xa0RTVWlTbnl6aTg2U0l1ZkZlTw==</auth>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Xa0RTVWlTbnl6aTg2U0l1ZkZlT05KU0lpTEJaNDhRWlJZdE52ZzQ4LHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V2tEU1VpU255emk4NlNJdWZGZU9OSlNJaUxCWjQ4UVpSWXROdmc0OCxwPU1zbXZGYjNybXhSZnFidmJDNlNxR1IvK3FQK0hUV2R4NUJ1NGhxcUIxT2c9</response>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:40 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:40 | [Mutex] received everything.

2019-11-25 20:30:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:40 | [Mutex] waiting for: [event]

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1IdW9PQkd5NkRiUkFuM0xTaDBnSw==</auth>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IdW9PQkd5NkRiUkFuM0xTaDBnS1ZFd1ZCWnhxaWhHeUxQTWFjekJsLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SHVvT0JHeTZEYlJBbjNMU2gwZ0tWRXdWQlp4cWloR3lMUE1hY3pCbCxwPUVFZFRJdDIyMXBOU2ozNEFVQllCWHVsekM0T1dZMXl4RE54cS9JZG5Jbk09</response>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:40 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:40 | [Mutex] received everything.

2019-11-25 20:30:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:40 | [Mutex] waiting for: [event]

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj12UExjQXY0SHNkWGd1clY3amI2Ng==</auth>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12UExjQXY0SHNkWGd1clY3amI2NndDenV3U3hPZmhONWdZemhjbHNkLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dlBMY0F2NEhzZFhndXJWN2piNjZ3Q3p1d1N4T2ZoTjVnWXpoY2xzZCxwPXBscDliNEdrRG42a1RwM2wzNHVoS3daWExRSWtXSFlkcWV3dW1SUVBtd2s9</response>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:40 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:40 | [Mutex] received everything.

2019-11-25 20:30:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:40 | [Mutex] waiting for: [event]

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1xejhldEw3RFpCYmVvZkl2MjhuTw==</auth>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xejhldEw3RFpCYmVvZkl2MjhuT1lFQkZldjRRSWU5TUZoYk5ucjRRLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cXo4ZXRMN0RaQmJlb2ZJdjI4bk9ZRUJGZXY0UUllOU1GaGJObnI0USxwPThGRnVyOXl1cDRIKzM1MzhnSk9QVyswSmVyOTN1OWJhOXJndzYwK1hWcEk9</response>

2019-11-25 20:30:40 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:40 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:40 | [Mutex] received everything.

2019-11-25 20:30:40 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:40 | [Mutex] waiting for: [event]

2019-11-25 20:30:40 | user :: user_w1nosj0027@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-25 20:30:40 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:41 | user :: user_w1nosj0027@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-25 20:30:41 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1pRGxmYUVPUDhSWmtibVNEblB0Yg==</auth>

2019-11-25 20:30:41 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pRGxmYUVPUDhSWmtibVNEblB0YmhwT3d3bDZzaEZXU2J4dWJvT3JWLHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:41 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aURsZmFFT1A4UlprYm1TRG5QdGJocE93d2w2c2hGV1NieHVib09yVixwPUlIVVBXQjRSSUpxM0xIN2ppVTJpeG1IK1pMbUs5b0RrQXFDTlNNUVBENTA9</response>

2019-11-25 20:30:41 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:41 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:41 | [Mutex] received everything.

2019-11-25 20:30:41 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:41 | [Mutex] notify: [event, disconnected]

2019-11-25 20:30:41 | user :: user_w1nosj0027@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-25 20:30:41 | user :: user_w1nosj0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:41 | user :: user_w1nosj0027@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-25 20:30:41 | user :: user_w1nosj0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3cxbm9zajAwMjcscj1qMWJvbUpDMmZBYjlhVU12Y3Zhdg==</auth>

2019-11-25 20:30:41 | user :: user_w1nosj0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qMWJvbUpDMmZBYjlhVU12Y3ZhdjdwRmdSZm81WTVMRlJJVEM1RHV0LHM9ZWN3UlJhMFdpcThrbFE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:41 | user :: user_w1nosj0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ajFib21KQzJmQWI5YVVNdmN2YXY3cEZnUmZvNVk1TEZSSVRDNUR1dCxwPXhuWWZWcGd1T0h2MWhQdldhSk1YU1hpZm1yaFZCdUhJaExpTEVObG0zT1U9</response>

2019-11-25 20:30:41 | user :: user_w1nosj0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: user_w1nosj0027@localhost is not authorized to act as user_w1nosj0027@localhost</text></failure>

2019-11-25 20:30:43 | [Mutex] waiting for: [user]

2019-11-25 20:30:43 | [Mutex] received everything.

2019-11-25 20:30:43 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-25 20:30:43 |

2019-11-25 20:30:43 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 20:30:43 | ------------------------------------

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6f8b16da

2019-11-25 20:30:43 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@26e5b780}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@614ce55b}, 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@65737daa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2071ef60}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@177b0072}, 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=Mon Nov 25 20:30:43 PST 2019}}}}

2019-11-25 20:30:43 | [Mutex] waiting for: [registration]

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@119b49fb

2019-11-25 20:30:43 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@614ce55b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@65737daa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2071ef60}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@177b0072}, 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=Mon Nov 25 20:30:43 PST 2019}}}}

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@6f7bf84f

2019-11-25 20:30:43 | 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-25 20:30:43 | 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-25 20:30:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@405e102f}

2019-11-25 20:30:43 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:43 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@f69f0c6

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@4476b441

2019-11-25 20:30:43 | 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-25 20:30:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@747f9500}

2019-11-25 20:30:43 | 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-25 20:30:43 | user :: null >> <iq to="localhost" id="VzIAFFFwwgCCs6sUS27JueD" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 20:30:43 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7ac72408}

2019-11-25 20:30:43 | user :: null << <iq id="VzIAFFFwwgCCs6sUS27JueD" xmlns="jabber:client" from="localhost" 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-25 20:30:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@44102cc8}

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@4bf1b4c

2019-11-25 20:30:43 | user :: null >> <iq to="localhost" id="mMjFJvcT7zk8u4wgIGmMQJX" type="set"><query xmlns="jabber:iq:register"><username>user_8ft1hy0028</username><password>user_8ft1hy0028</password><email>3034d5e1-08ee-42e3-bdd4-ddf77121c63d@localhost</email></query></iq>

2019-11-25 20:30:43 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@de951a9a}

2019-11-25 20:30:43 | user :: null << <iq id="mMjFJvcT7zk8u4wgIGmMQJX" xmlns="jabber:client" from="localhost" type="result"/>

2019-11-25 20:30:43 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@751a6326}

2019-11-25 20:30:43 | [Mutex] received everything.

2019-11-25 20:30:43 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 20:30:43 | 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;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@405e102f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@747f9500]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@614ce55b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@65737daa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2071ef60}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@177b0072}, 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=Mon Nov 25 20:30:43 PST 2019}}}}

2019-11-25 20:30:43 | 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;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@405e102f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@747f9500]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@614ce55b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@65737daa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2071ef60}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@177b0072}, 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=Mon Nov 25 20:30:43 PST 2019}}}}

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7d453f10

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@38762a1c

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@446f3325

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@624a6bdd

2019-11-25 20:30:43 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@36a3653b

2019-11-25 20:30:43 | user :: user_8ft1hy0028@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-25 20:30:43 | user :: user_8ft1hy0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@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-25 20:30:43 | user :: user_8ft1hy0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzhmdDFoeTAwMjgscj1hZ0JGSVFLOVZ4OEh2c2pXRVlXOA==</auth>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hZ0JGSVFLOVZ4OEh2c2pXRVlXOGV2V0NueWJmYWZkQTRaMFJKTllRLHM9bjZIYzQ5YlczSDBsQ3c9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YWdCRklRSzlWeDhIdnNqV0VZVzhldldDbnliZmFmZEE0WjBSSk5ZUSxwPVViWlRBbU42d2xycG5QRXB0L2pnTGVYQU9IWHhtcVdlUW9SNHBlYlVDdVE9</response>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1aeTZjcStsU0xWWEpwSFAvWDZtRHNQdkZHYXNWZHlTM0xGdGFwNCtQSmNNPQ==</success>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@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 xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" hash="SHA-1"/></features>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost >> <iq xmlns="jabber:client" id="oXODsp9Dso06AoYcoQYZtYc" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost << <iq id="oXODsp9Dso06AoYcoQYZtYc" xmlns="jabber:client" type="result" to="user_8ft1hy0028@localhost/993927746-tigase-20"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_8ft1hy0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="bBIEtXgSPW9l1hDFnWn5vcS" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost/993927746-tigase-20 << <iq id="bBIEtXgSPW9l1hDFnWn5vcS" xmlns="jabber:client" type="result" to="user_8ft1hy0028@localhost/993927746-tigase-20"/>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="NFS0hBxjHNDsp9Dso06AoYc" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost/993927746-tigase-20 << <enabled id="09be8cd1-d62a-43a8-9fad-1005babfca8f" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60" resume="true"/>

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost/993927746-tigase-20 >> <iq id="CBEkWVlIGx5woR0hBxjHNDs" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost/993927746-tigase-20 << <iq id="CBEkWVlIGx5woR0hBxjHNDs" xmlns="jabber:client" type="result" to="user_8ft1hy0028@localhost/993927746-tigase-20"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:30:43 | Disconnecting

2019-11-25 20:30:43 | user :: user_8ft1hy0028@localhost/993927746-tigase-20 << <presence from="user_8ft1hy0028@localhost/993927746-tigase-20" xmlns="jabber:client" to="user_8ft1hy0028@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-25 20:30:43 | [Mutex] notify: [disconnected]

2019-11-25 20:30:43 | [Mutex] received everything.

2019-11-25 20:30:43 | [Mutex] waiting for: [event]

2019-11-25 20:30:43 | user :: user_8ft1hy0028@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-25 20:30:43 | user :: user_8ft1hy0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:30:44 | user :: user_8ft1hy0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OZVR5RWtHTnJkUFJuTlpPU05ib2ZMWXF5Nk91S25YRzlyWWtDVWpuLHM9bjZIYzQ5YlczSDBsQ3c9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:44 | user :: user_8ft1hy0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TmVUeUVrR05yZFBSbk5aT1NOYm9mTFlxeTZPdUtuWEc5cllrQ1VqbixwPUhyNUJvRmp3SThCYUQvTlZWM2FCOVBRRnc2aDZ4SGw4d2VKd2xxTUF5ZjQ9</response>

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

2019-11-25 20:30:44 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:44 | [Mutex] received everything.

2019-11-25 20:30:44 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:44 | [Mutex] waiting for: [event]

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

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

2019-11-25 20:30:44 | user :: user_8ft1hy0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OcWE2TjZ6ZGN2UDhjSDVzWEtoUlFOR3lpMnZtYTZvZjU3clBrMDI1LHM9bjZIYzQ5YlczSDBsQ3c9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:44 | user :: user_8ft1hy0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TnFhNk42emRjdlA4Y0g1c1hLaFJRTkd5aTJ2bWE2b2Y1N3JQazAyNSxwPWJpdm5COGxHN3hxV2hYVm8xdWY3ZE5HQmdTNG9xcWR0Y0UzWXNiQ2JMcWM9</response>

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

2019-11-25 20:30:44 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:44 | [Mutex] received everything.

2019-11-25 20:30:44 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:44 | [Mutex] notify: [event, disconnected]

2019-11-25 20:30:44 | [Mutex] waiting for: [event]

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

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

2019-11-25 20:30:44 | user :: user_8ft1hy0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TZVBZUjFHVEF5b3ZGQWNKNWNCeHp0MUJDV3R0TGs2ZkpQb1J4VG94LHM9bjZIYzQ5YlczSDBsQ3c9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:44 | user :: user_8ft1hy0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U2VQWVIxR1RBeW92RkFjSjVjQnh6dDFCQ1d0dExrNmZKUG9SeFRveCxwPXFjZW5LV3FzVkRrZFcwVXRCaFVveEtkd1ovWTdCSGZNNkhhVHJWWVA5Znc9</response>

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

2019-11-25 20:30:44 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:44 | [Mutex] received everything.

2019-11-25 20:30:44 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:44 | [Mutex] waiting for: [event]

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

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

2019-11-25 20:30:44 | user :: user_8ft1hy0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rUHBGS3V4eE53VmtIZ0RkaklWam41WFdhUUZ4ZE1LeW95SVJyejRoLHM9bjZIYzQ5YlczSDBsQ3c9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:44 | user :: user_8ft1hy0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a1BwRkt1eHhOd1ZrSGdEZGpJVmpuNVhXYVFGeGRNS3lveUlScno0aCxwPTJwT1JxU2dINEZMbC9FaGdDMnh2Tmh0WkNsOStPN2VaQ3h3b2Q1U2hMUUU9</response>

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

2019-11-25 20:30:44 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:44 | [Mutex] received everything.

2019-11-25 20:30:44 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-25 20:30:44 | user :: user_8ft1hy0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BZ3A4cE9ZSGxtazdQcHEwT3FDVlVsa3k1anZEUUhjU1Bmejczc1I1LHM9bjZIYzQ5YlczSDBsQ3c9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:44 | user :: user_8ft1hy0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QWdwOHBPWUhsbWs3UHBxME9xQ1ZVbGt5NWp2RFFIY1NQZno3M3NSNSxwPTArQzlnK2plMGF5YWg5WGJwYktQMVRWLy9HaWRrSDVFald3S3YzUVZ2Vkk9</response>

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

2019-11-25 20:30:46 | [Mutex] waiting for: [user]

2019-11-25 20:30:46 | [Mutex] received everything.

2019-11-25 20:30:46 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-25 20:30:46 |

2019-11-25 20:30:46 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 20:30:46 | ------------------------------------

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7c480af8

2019-11-25 20:30:46 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@26e5b780}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@728feb01}, 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@76b06188}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@33b2e13a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f11327e}, 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=Mon Nov 25 20:30:46 PST 2019}}}}

2019-11-25 20:30:46 | [Mutex] waiting for: [registration]

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2cb177e

2019-11-25 20:30:46 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@728feb01}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@76b06188}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@33b2e13a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f11327e}, 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=Mon Nov 25 20:30:46 PST 2019}}}}

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@77829a8e

2019-11-25 20:30:46 | 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-25 20:30:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@539d1e75}

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

2019-11-25 20:30:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@551944ba

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@fb3c980

2019-11-25 20:30:46 | 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-25 20:30:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6c867412}

2019-11-25 20:30:46 | 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-25 20:30:46 | user :: null >> <iq to="localhost" id="0SnO0eEy6gOFPGCpP0mNS15" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 20:30:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@70d4b0eb}

2019-11-25 20:30:46 | user :: null << <iq id="0SnO0eEy6gOFPGCpP0mNS15" xmlns="jabber:client" from="localhost" 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-25 20:30:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@57d3a141}

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@48f00395

2019-11-25 20:30:46 | user :: null >> <iq to="localhost" id="g1MBufxp3bLzk9DBogKAykQ" type="set"><query xmlns="jabber:iq:register"><username>user_9bk36a0029</username><password>user_9bk36a0029</password><email>e7528727-661e-4c24-a8dd-9cd6c50bb821@localhost</email></query></iq>

2019-11-25 20:30:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ff1594ae}

2019-11-25 20:30:46 | user :: null << <iq id="g1MBufxp3bLzk9DBogKAykQ" xmlns="jabber:client" from="localhost" type="result"/>

2019-11-25 20:30:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@599e3cc2}

2019-11-25 20:30:46 | [Mutex] received everything.

2019-11-25 20:30:46 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 20:30:46 | 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;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@539d1e75, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6c867412]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@728feb01}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@76b06188}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@33b2e13a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f11327e}, 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=Mon Nov 25 20:30:46 PST 2019}}}}

2019-11-25 20:30:46 | 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;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@539d1e75, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6c867412]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@728feb01}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@76b06188}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@33b2e13a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@f11327e}, 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=Mon Nov 25 20:30:46 PST 2019}}}}

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6e7e507

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@4cf48533

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4d0cb93

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2c808fe7

2019-11-25 20:30:46 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@15f688ad

2019-11-25 20:30:46 | user :: user_9bk36a0029@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-25 20:30:46 | user :: user_9bk36a0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:46 | user :: user_9bk36a0029@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-25 20:30:46 | user :: user_9bk36a0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzliazM2YTAwMjkscj1TajZQWTJFdDBMb2hZT1ZGWTFUbw==</auth>

2019-11-25 20:30:46 | user :: user_9bk36a0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TajZQWTJFdDBMb2hZT1ZGWTFUb0libUxocjlSWXBpVHpPbEozbXdsLHM9aFh6dXdoNDRzdnUyYVE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U2o2UFkyRXQwTG9oWU9WRlkxVG9JYm1MaHI5UllwaVR6T2xKM213bCxwPVU0T0l3Tjd3dXRYZ2hnbUQvNWFhZ1FmWi8rbmVhODVIWmhNMDk4V05LZjA9</response>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0wRW15Mi8wWm4zaDlPT2F2L0N5ZnZMMWVmRkpVVHRMNklrSkNDdDh3TjFJPQ==</success>

2019-11-25 20:30:47 | user :: user_9bk36a0029@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 xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" hash="SHA-1"/></features>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost >> <iq xmlns="jabber:client" id="wUpS8uaAao4bRKKFl2qV8x7" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost << <iq id="wUpS8uaAao4bRKKFl2qV8x7" xmlns="jabber:client" type="result" to="user_9bk36a0029@localhost/993927746-tigase-21"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_9bk36a0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="OZCtZjRNZ1eXfPQaycMMKKu" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost/993927746-tigase-21 << <iq id="OZCtZjRNZ1eXfPQaycMMKKu" xmlns="jabber:client" type="result" to="user_9bk36a0029@localhost/993927746-tigase-21"/>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="L4PY1kVT7t1rV2zthKYaqeG" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost/993927746-tigase-21 << <enabled id="f9d2e9d6-790a-43d4-a380-c0cd836e2a97" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60" resume="true"/>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost/993927746-tigase-21 >> <iq id="o8ZZaPZjO6qWgKGCewkHTOS" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost/993927746-tigase-21 << <iq id="o8ZZaPZjO6qWgKGCewkHTOS" xmlns="jabber:client" type="result" to="user_9bk36a0029@localhost/993927746-tigase-21"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:30:47 | Disconnecting

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

2019-11-25 20:30:47 | [Mutex] notify: [disconnected]

2019-11-25 20:30:47 | [Mutex] received everything.

2019-11-25 20:30:47 | [Mutex] waiting for: [event]

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyXzliazM2YTAwMjkscj1LMG16WEdqMUVkTG42TWNtQ1o5SQ==</auth>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LMG16WEdqMUVkTG42TWNtQ1o5SUdxelRLQXZBWmF5anRvSE55M1BELHM9VEdkRE9sb2JoVEROa3c9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SzBtelhHajFFZExuNk1jbUNaOUlHcXpUS0F2QVpheWp0b0hOeTNQRCxwPVd2cmpBaThrMy94MnF0RlQ1a1UzeTNjSHR2Zz0=</response>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:47 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:47 | [Mutex] received everything.

2019-11-25 20:30:47 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:47 | [Mutex] waiting for: [event]

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfOWJrMzZhMDAyOQAgLSAtIC0gLSAt</auth>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:47 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:47 | [Mutex] received everything.

2019-11-25 20:30:47 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:47 | [Mutex] waiting for: [event]

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyXzliazM2YTAwMjkscj1nWEtlZDN6UDZYeTVGcUJlYzd2QQ==</auth>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nWEtlZDN6UDZYeTVGcUJlYzd2QTFmd2ZzOTB1U1JTRE9MV3lsMlU3LHM9VEdkRE9sb2JoVEROa3c9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z1hLZWQzelA2WHk1RnFCZWM3dkExZndmczkwdVNSU0RPTFd5bDJVNyxwPWhVUlBJTmticDk0NERHSjlLRGVEcHk2bUF6TT0=</response>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:47 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:47 | [Mutex] received everything.

2019-11-25 20:30:47 | [Mutex] notify: [event, disconnected]

2019-11-25 20:30:47 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:47 | [Mutex] waiting for: [event]

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfOWJrMzZhMDAyOQAgLSAtIC0gLSAt</auth>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:47 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:47 | [Mutex] received everything.

2019-11-25 20:30:47 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:47 | user :: user_9bk36a0029@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-25 20:30:47 | user :: user_9bk36a0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzliazM2YTAwMjkscj1aRlBwc0d1dGU0dU83RHFsTllKTQ==</auth>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aRlBwc0d1dGU0dU83RHFsTllKTUQzZ1ViTEZ5V0ZXVGRibVQwVEd1LHM9aFh6dXdoNDRzdnUyYVE9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WkZQcHNHdXRlNHVPN0RxbE5ZSk1EM2dVYkxGeVdGV1RkYm1UMFRHdSxwPTlnNjQ2N1Avc0xzKzlUUCtLZmpxYWR0U3h1bmxYK2kzSEdCZ0pFcXVoTTA9</response>

2019-11-25 20:30:47 | user :: user_9bk36a0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:49 | [Mutex] waiting for: [user]

2019-11-25 20:30:49 | [Mutex] received everything.

2019-11-25 20:30:49 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-25 20:30:49 |

2019-11-25 20:30:49 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 20:30:49 | ------------------------------------

2019-11-25 20:30:49 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@9e100e2

2019-11-25 20:30:49 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@26e5b780}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@726efae}, 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@3196b92}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@461be595}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@477c1ba4}, 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=Mon Nov 25 20:30:49 PST 2019}}}}

2019-11-25 20:30:49 | [Mutex] waiting for: [registration]

2019-11-25 20:30:49 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7717c77a

2019-11-25 20:30:49 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@726efae}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@3196b92}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@461be595}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@477c1ba4}, 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=Mon Nov 25 20:30:49 PST 2019}}}}

2019-11-25 20:30:49 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@3f9a67f1

2019-11-25 20:30:49 | 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-25 20:30:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@26341ada}

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

2019-11-25 20:30:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-25 20:30:49 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1b29483

2019-11-25 20:30:49 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@48d7bfd8

2019-11-25 20:30:49 | 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-25 20:30:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@249eecdc}

2019-11-25 20:30:49 | 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-25 20:30:49 | user :: null >> <iq to="localhost" id="l7QTR7hKZjX6GAgU2gMyaCh" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 20:30:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4cff772f}

2019-11-25 20:30:49 | user :: null << <iq id="l7QTR7hKZjX6GAgU2gMyaCh" xmlns="jabber:client" from="localhost" 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-25 20:30:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@227ac05f}

2019-11-25 20:30:49 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@37795e1f

2019-11-25 20:30:49 | user :: null >> <iq to="localhost" id="l8RVVfxg1n5mcCk2iMOCiSN" type="set"><query xmlns="jabber:iq:register"><username>user_67bi310030</username><password>user_67bi310030</password><email>5d0ddc95-9cae-452e-a41c-59aabefdc9e8@localhost</email></query></iq>

2019-11-25 20:30:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1c59cece}

2019-11-25 20:30:49 | user :: null << <iq id="l8RVVfxg1n5mcCk2iMOCiSN" xmlns="jabber:client" from="localhost" type="result"/>

2019-11-25 20:30:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@42250e57}

2019-11-25 20:30:49 | [Mutex] received everything.

2019-11-25 20:30:49 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 20:30:49 | 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;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@26341ada, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@249eecdc]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@726efae}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@3196b92}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@461be595}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@477c1ba4}, 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=Mon Nov 25 20:30:49 PST 2019}}}}

2019-11-25 20:30:49 | 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;@26e5b780}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@26341ada, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@249eecdc]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@726efae}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@67d8bdbb}, 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@3196b92}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@461be595}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@477c1ba4}, 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=Mon Nov 25 20:30:49 PST 2019}}}}

2019-11-25 20:30:49 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@110ef2c3

2019-11-25 20:30:49 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6582a085

2019-11-25 20:30:49 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@18f6838c

2019-11-25 20:30:49 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@72cb7173

2019-11-25 20:30:50 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@14b51d03

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzY3YmkzMTAwMzAscj11TlZ5OUV3aEpxMnlDQWlVWEFVMA==</auth>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11TlZ5OUV3aEpxMnlDQWlVWEFVMHoxWVpRajlaT1luZXNZUWhWY2hzLHM9SVN1Q0piZCt2UStsZGc9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dU5WeTlFd2hKcTJ5Q0FpVVhBVTB6MVlaUWo5Wk9ZbmVzWVFoVmNocyxwPVlaTTdBM09zaHI1bGxkMWlwU1BBVjBaUTJiOW9nWU04Q2hzd2dQd1VpOG89</response>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1kK2EvN3M2M1Y5SjJwZ1JCbVluL3VIVkFvK0NJTlNxTmVqdU1taVZzbUpjPQ==</success>

2019-11-25 20:30:50 | user :: user_67bi310030@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 xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" hash="SHA-1"/></features>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost >> <iq xmlns="jabber:client" id="R9SXZnNM3rdCIEoayiQGq8j" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <iq id="R9SXZnNM3rdCIEoayiQGq8j" xmlns="jabber:client" type="result" to="user_67bi310030@localhost/993927746-tigase-22"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_67bi310030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="j6Hp9x9Hr4DBxg0eyucAqQK" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-22 << <iq id="j6Hp9x9Hr4DBxg0eyucAqQK" xmlns="jabber:client" type="result" to="user_67bi310030@localhost/993927746-tigase-22"/>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-22 >> <iq to="localhost" id="nV8DjO7zt8KIwq4kUOGElbo" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-22 >> <iq id="QU3p3bLzk9DBogKAykQWSOU" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-22 << <enabled id="73ec2970-2113-49a3-97cd-661b5cdfe549" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60" resume="true"/>

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

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-22 << <iq id="QU3p3bLzk9DBogKAykQWSOU" xmlns="jabber:client" type="result" to="user_67bi310030@localhost/993927746-tigase-22"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:30:50 | Disconnecting

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

2019-11-25 20:30:50 | [Mutex] notify: [disconnected]

2019-11-25 20:30:50 | [Mutex] received everything.

2019-11-25 20:30:50 | [Mutex] waiting for: [event]

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzY3YmkzMTAwMzAscj1hRWpIMmZCV2F3d2RqZVFEeEt0RQ==</auth>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hRWpIMmZCV2F3d2RqZVFEeEt0RUhHWjlCRGVGUzd4MElUM25abHkxLHM9SVN1Q0piZCt2UStsZGc9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YUVqSDJmQldhd3dkamVRRHhLdEVIR1o5QkRlRlM3eDBJVDNuWmx5MSxwPTRmc1k3eituVHlHaEFzMlhSWmNTOHRkUVNlU0tsWHE3b2lOTDF1NXE0bk09</response>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:50 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:50 | [Mutex] received everything.

2019-11-25 20:30:50 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:50 | [Mutex] waiting for: [event]

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzY3YmkzMTAwMzAscj1ocFVnckk3WEJmOFpEdFNKbUlVUg==</auth>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ocFVnckk3WEJmOFpEdFNKbUlVUlBVbG9vNURMc1ZjZ2RuTzdaNlRiLHM9SVN1Q0piZCt2UStsZGc9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aHBVZ3JJN1hCZjhaRHRTSm1JVVJQVWxvbzVETHNWY2dkbk83WjZUYixwPTZIdHdWckN5cmxlVzRyMys4Q3IrYk9iL3dUbndCZXNGeW9zV3U2c1htMm89</response>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:50 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:50 | [Mutex] received everything.

2019-11-25 20:30:50 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:50 | [Mutex] waiting for: [event]

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzY3YmkzMTAwMzAscj1ldWFYRm9BZzJoa1k5eTdlT200YQ==</auth>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ldWFYRm9BZzJoa1k5eTdlT200YTZRNnVkZ3l5ejhtZFR2c0N4UU1wLHM9SVN1Q0piZCt2UStsZGc9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZXVhWEZvQWcyaGtZOXk3ZU9tNGE2UTZ1ZGd5eXo4bWRUdnNDeFFNcCxwPVRGd2JmM2dVNDM4Z1FEYWZkZmNVTGRvbnA3MVFrd1o3bjVrWWhid29JR289</response>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-25 20:30:50 | [Mutex] notify: [event, authFailed]

2019-11-25 20:30:50 | [Mutex] received everything.

2019-11-25 20:30:50 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzY3YmkzMTAwMzAscj15WmhuWEdMYVM4SG9GQjNoQUI5bQ==</auth>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15WmhuWEdMYVM4SG9GQjNoQUI5bXFMR0JZY0tvN29oTWJpR2dEYzV3LHM9SVN1Q0piZCt2UStsZGc9PSxpPTQwOTY=</challenge>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eVpoblhHTGFTOEhvRkIzaEFCOW1xTEdCWWNLbzdvaE1iaUdnRGM1dyxwPVNoWVMwUFUrWVFxR1o0SjRWTDl6STA4M1MybndSTHlUTDBvK2MwTVY1T1U9</response>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0yYXlpNmx3dE9pZ2xnMDB1ZXUzSEpubEkvamdHZmltMktFSXJ0Q1NkMXU0PQ==</success>

2019-11-25 20:30:50 | user :: user_67bi310030@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 xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" hash="SHA-1"/></features>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost >> <iq xmlns="jabber:client" id="36BmYWWanfwiLxqcteJvlVV" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost << <iq id="36BmYWWanfwiLxqcteJvlVV" xmlns="jabber:client" type="result" to="user_67bi310030@localhost/993927746-tigase-23"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_67bi310030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="eUZiWXcFn5pTbp0vl1eW6iY" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-23 << <iq id="eUZiWXcFn5pTbp0vl1eW6iY" xmlns="jabber:client" type="result" to="user_67bi310030@localhost/993927746-tigase-23"/>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-23 >> <iq to="localhost" id="Mg15sbp9x9Hr4DBxg0eyucA" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-23 << <enabled id="8397992d-38da-47ec-9ad7-9421cb71af18" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60" resume="true"/>

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-23 >> <iq id="okbnWn5vcSY2s8sakIItrU4" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-25 20:30:50 | user :: user_67bi310030@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-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-23 << <iq id="okbnWn5vcSY2s8sakIItrU4" xmlns="jabber:client" type="result" to="user_67bi310030@localhost/993927746-tigase-23"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:30:50 | Disconnecting

2019-11-25 20:30:50 | user :: user_67bi310030@localhost/993927746-tigase-23 << <presence from="user_67bi310030@localhost/993927746-tigase-23" xmlns="jabber:client" to="user_67bi310030@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-25 20:30:50 | [Mutex] notify: [disconnected]

2019-11-25 20:30:50 | [Mutex] received everything.

2019-11-25 20:30:52 | [Mutex] waiting for: [user]

2019-11-25 20:30:52 | [Mutex] received everything.

2019-11-25 20:30:52 | [Mutex] isItemNotified: user:ok:true :: true