Brute Force Prevention

2019-11-25 18:44:10 |

2019-11-25 18:44:10 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 18:44:10 | ------------------------------------

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@444ee366

2019-11-25 18:44:10 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1c9780c5}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4a89059f}, 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@4eb68816}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@bb40fa4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@38528867}, 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 18:44:10 PST 2019}}}}

2019-11-25 18:44:10 | [Mutex] waiting for: [registration]

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3af5c70f

2019-11-25 18:44:10 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4a89059f}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@4eb68816}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@bb40fa4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@38528867}, 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 18:44:10 PST 2019}}}}

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@40f91e7f

2019-11-25 18:44:10 | 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 18:44:10 | 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 18:44:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6b9bf0eb}

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

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

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@47a64c4f

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@537f260b

2019-11-25 18:44:10 | 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 18:44:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5bfdd0fd}

2019-11-25 18:44:10 | 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 18:44:10 | user :: null >> <iq to="localhost" id="5rAn8GHzdtWXmKYo1w7mZZa" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 18:44:10 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8f632053}

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

2019-11-25 18:44:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6fd56fc1}

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1ae49240

2019-11-25 18:44:10 | user :: null >> <iq to="localhost" id="5sBpcOX5fx4dSM2wh29q7fG" type="set"><query xmlns="jabber:iq:register"><username>user_hjckgn0027</username><password>user_hjckgn0027</password><email>a2d522be-9019-4fd3-9c29-e32959f9db45@localhost</email></query></iq>

2019-11-25 18:44:10 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@606bdb55}

2019-11-25 18:44:10 | user :: null << <iq from="localhost" id="5sBpcOX5fx4dSM2wh29q7fG" type="result" xmlns="jabber:client"/>

2019-11-25 18:44:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3081b069}

2019-11-25 18:44:10 | [Mutex] received everything.

2019-11-25 18:44:10 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 18:44:10 | 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;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6b9bf0eb, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5bfdd0fd]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4a89059f}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@4eb68816}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@bb40fa4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@38528867}, 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 18:44:10 PST 2019}}}}

2019-11-25 18:44:10 | 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;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6b9bf0eb, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5bfdd0fd]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4a89059f}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@4eb68816}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@bb40fa4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@38528867}, 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 18:44:10 PST 2019}}}}

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@54ee4bc

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@412128b3

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7fe9d445

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@42562129

2019-11-25 18:44:10 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@304f56db

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

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

2019-11-25 18:44:10 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OY0hENW9aUWZqUkw2TG5wYzlnRDl6aWlmU0QxV2h4ZVdMYzV5cUdtLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:10 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TmNIRDVvWlFmalJMNkxucGM5Z0Q5emlpZlNEMVdoeGVXTGM1eXFHbSxwPUtHNFBGUVU0M1FZeDEzTVpjVHBOeWsyWjk1T1pDbHlOSDY5TUZDa0daTEk9</response>

2019-11-25 18:44:10 | user :: user_hjckgn0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj00Z0hRNEVqTHBhblRHako2SjRiazNINGZCYXVvbUF3RnFIbWpOUDEwTEVnPQ==</success>

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

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost >> <iq xmlns="jabber:client" id="XUVYhHsgHqgWV5ywnVVTMDI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost << <iq id="XUVYhHsgHqgWV5ywnVVTMDI" type="result" xmlns="jabber:client" to="user_hjckgn0027@localhost/993927746-tigase-19"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_hjckgn0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="5uDtk4t7jFkJUQaMN4dynLI" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost/993927746-tigase-19 << <iq id="5uDtk4t7jFkJUQaMN4dynLI" type="result" xmlns="jabber:client" to="user_hjckgn0027@localhost/993927746-tigase-19"/>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="YCZhHsgHqgWV5ywnVVTMDIs" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost/993927746-tigase-19 << <enabled location="d4270859fb27" id="11f8defd-b34d-413e-aa8b-6b33c0c4e1e8" max="60" xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost/993927746-tigase-19 >> <iq id="6IfQ6xfzbmN26GORct4pPQW" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost/993927746-tigase-19 << <iq id="6IfQ6xfzbmN26GORct4pPQW" type="result" xmlns="jabber:client" to="user_hjckgn0027@localhost/993927746-tigase-19"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 18:44:11 | Disconnecting

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

2019-11-25 18:44:11 | [Mutex] notify: [disconnected]

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

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

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

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

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10NllaYmVkUURlOTkzOGM3UUJPcFBkQ0Z4amVFZ1hCUHFwQVlOU0h5LHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dDZZWmJlZFFEZTk5MzhjN1FCT3BQZENGeGplRWdYQlBxcEFZTlNIeSxwPXVZU1k1eVBvRlBscmZyVXYvYmJYekROMnZWakVLYzJzYzNQVjRFZlFFQUE9</response>

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

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

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

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

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

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

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

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00M01MRXZhbEZTb0RuVk1yazZiRDVKamxHbFdENml3akMyS3I2ODRnLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NDNNTEV2YWxGU29EblZNcms2YkQ1SmpsR2xXRDZpd2pDMktyNjg0ZyxwPVk3Zmo2eGQ3T1N3SWdNaE5uRDF2NkZVck82cjd2VmphZGswekZqT0ZPZ2M9</response>

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

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

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

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

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

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

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

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xQTFDYzk5VHZ3SVVFdUoxUHdsa21rcHBZUHExV1Q2c0pLQWxFb2JsLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MUExQ2M5OVR2d0lVRXVKMVB3bGtta3BwWVBxMVdUNnNKS0FsRW9ibCxwPWxzaXFJclFHWm5pWWtSQlhQSG9ydThaWXRKM3FBN1BEVG9pVUh3bDZtTTA9</response>

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

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

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

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

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

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

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

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

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vNlVmZW50cEpxSFlyTWVlN1pWRnFpUTF6V1BJUE1aM3hZNEQxMDdtLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bzZVZmVudHBKcUhZck1lZTdaVkZxaVExeldQSVBNWjN4WTREMTA3bSxwPTdkeVNnUDF0dzR0N3liWlAxZ095cklZSzJvVU92Q01zT2FRTE1TRGlXcE09</response>

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

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

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

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

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

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

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

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Db0hxbm5YeTJBaDIxaEJMamxaSlN6eGoybWhyNEQyUGVkMVN0ZzdZLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q29IcW5uWHkyQWgyMWhCTGpsWkpTenhqMm1ocjREMlBlZDFTdGc3WSxwPSszSHB0eUtRdnZldGs4SzY5bCtGUWJpVHJ5TG5CbE40Yk1mMU9PcnJjOFE9</response>

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

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

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

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

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

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

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

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KWFFTUXBNblZZeFczNGJkUDBKRm9CR1RVYXdRV0dmQzdtMm5UYWxDLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SlhRU1FwTW5WWXhXMzRiZFAwSkZvQkdUVWF3UVdHZkM3bTJuVGFsQyxwPXZZSEVQRnZIUTUxSThVeDI5bFJ4cU40OFBFcUhXWk10amhnNGh2SjBGd1U9</response>

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

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

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

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

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

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

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

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zRWFHZWlaQjdZSFdvVU9Qb0J1V0NzUXlPM2lZMm1YdXM2SEVKY3dzLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:11 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M0VhR2VpWkI3WUhXb1VPUG9CdVdDc1F5TzNpWTJtWHVzNkhFSmN3cyxwPWZCV0FPWUxIbFMzUFJicUhtQnlLbFVIWmxHNzE5c2VLWmxZOW5nM2EyblU9</response>

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

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

2019-11-25 18:44:12 | [Mutex] received everything.

2019-11-25 18:44:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:12 | [Mutex] notify: [event, disconnected]

2019-11-25 18:44:12 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DNVdGc3o0UjltdG84UnlOVlFtZmRMYmtKSHlCQjZjODlIY0tEdFF2LHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QzVXRnN6NFI5bXRvOFJ5TlZRbWZkTGJrSkh5QkI2Yzg5SGNLRHRRdixwPUY5V3VONHd1QVl3dG5PVWp6RWlFY1JTTGVrNXhvMmtmejlVRDhsM29zdnM9</response>

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

2019-11-25 18:44:12 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:12 | [Mutex] received everything.

2019-11-25 18:44:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:12 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Ia1N5dGFBcERMYkRoQUNWOWZtZThTalY1NUFtaEtmVUR4aE8ybG40LHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SGtTeXRhQXBETGJEaEFDVjlmbWU4U2pWNTVBbWhLZlVEeGhPMmxuNCxwPU0yZ0l0dy9hQ1BTcmhmY3lKWW8yanozR1Q2UlBWWGVjakdra09CaEJJWkk9</response>

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

2019-11-25 18:44:12 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:12 | [Mutex] received everything.

2019-11-25 18:44:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:12 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aN3JubEhxb3pnYnVacURpRDluT3Fwa2hueUE3TExKM3VwZDJvaEVLLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WjdybmxIcW96Z2J1WnFEaUQ5bk9xcGtobnlBN0xMSjN1cGQyb2hFSyxwPW4yU3cxNExucDZrZ1FKdWl3a2VxWnlQVU8vSnVSVHVJR1lUN3VhRThadWs9</response>

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

2019-11-25 18:44:12 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:12 | [Mutex] received everything.

2019-11-25 18:44:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:12 | [Mutex] notify: [event, disconnected]

2019-11-25 18:44:12 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zRGUxZDY3TXRuM3MyeERIT2k1SnJ5VXZ6ZGtsd1pyWmRLSmFjTUJYLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M0RlMWQ2N010bjNzMnhESE9pNUpyeVV2emRrbHdaclpkS0phY01CWCxwPTgycDNuMFE5T1h4TXhwYnYyZHMrUFZxQWFtdG01dHd1TUkzSzUzVFQ0Wk09</response>

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

2019-11-25 18:44:12 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:12 | [Mutex] received everything.

2019-11-25 18:44:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:12 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YQVlmd3NIV0xLSnF4OWxGNW5wZTdJYkk2YjZOVG4wNUdDOXZaNEU3LHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WEFZZndzSFdMS0pxeDlsRjVucGU3SWJJNmI2TlRuMDVHQzl2WjRFNyxwPTZhMHFkM25vOEJkWlNYb0x3Ykl3VW00QzA5d1NZT0dsWXR5ZzNvb3FzeUk9</response>

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

2019-11-25 18:44:12 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:12 | [Mutex] received everything.

2019-11-25 18:44:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:12 | [Mutex] notify: [event, disconnected]

2019-11-25 18:44:12 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UenJDc3JLcUM0aWREQ2VCMGg3RTFtVzNGNlI5YnlCYzM3azJCOFhjLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:12 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VHpyQ3NyS3FDNGlkRENlQjBoN0UxbVczRjZSOWJ5QmMzN2syQjhYYyxwPU5KUEZ3RTkzaEo5YitmL0R0ZEROcFBkZGtYcXh3amNaUnRMU1pkSWowMTg9</response>

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

2019-11-25 18:44:12 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:12 | [Mutex] received everything.

2019-11-25 18:44:12 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:12 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QbnVJRG9DOGRZN1lWbVJnOUdpbjVIWVJ3MnRtZVg0ZTFiWG5WNmJGLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UG51SURvQzhkWTdZVm1SZzlHaW41SFlSdzJ0bWVYNGUxYlhuVjZiRixwPWZmTVhoOVA5Rncyc2s3TGwveC90eVg1TDNWUmMxcTVJN0hKdm5nN3N4N0k9</response>

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

2019-11-25 18:44:13 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:13 | [Mutex] received everything.

2019-11-25 18:44:13 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:13 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iU0RxcjFEOHRpa2NpaFB3ZWJ2SVROVDRzb1hmQ1hCbVBpaHBkbjFCLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YlNEcXIxRDh0aWtjaWhQd2VidklUTlQ0c29YZkNYQm1QaWhwZG4xQixwPXZLeWt0eks3RXFQZ3ZuLzVyTjNaalFqc2RpeHBqakYzU25KUWVwRWN1ZkE9</response>

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

2019-11-25 18:44:13 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:13 | [Mutex] received everything.

2019-11-25 18:44:13 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:13 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kdDV5TWswZzlzdWMzN0JXWTFzdlNpTklUdkF2M3k3VHEwMkoza0ZDLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZHQ1eU1rMGc5c3VjMzdCV1kxc3ZTaU5JVHZBdjN5N1RxMDJKM2tGQyxwPTNzbWt3YW8zVlBsZ1drUTE4WUFoTUNIKzFnTndjSDFic3lDa3lFcU9OeUk9</response>

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

2019-11-25 18:44:13 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:13 | [Mutex] received everything.

2019-11-25 18:44:13 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:13 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NVmx2bEdHRVVHMm1YZTVWTzRLRVNqeDdoZXV1RXlQWFhNNGlZWDBvLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TVZsdmxHR0VVRzJtWGU1Vk80S0VTang3aGV1dUV5UFhYTTRpWVgwbyxwPUJrZWhySzVlTkg2b0NDTzJCVTlHTWNYOVFRZ2RxQVcxNEYvOVBObm1iTHc9</response>

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

2019-11-25 18:44:13 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:13 | [Mutex] received everything.

2019-11-25 18:44:13 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:13 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tSHM1ZE9DUzRiRk03T0VlUUk1T1pITVVhdmxOZ1ZrOXFmTGpXd2tKLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bUhzNWRPQ1M0YkZNN09FZVFJNU9aSE1VYXZsTmdWazlxZkxqV3drSixwPXRGMWw2eVpwUGg1TkF5VWk1ZHhobjJpOTVzWU5qUTlwQWx1dG5ic1ZZUGc9</response>

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

2019-11-25 18:44:13 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:13 | [Mutex] received everything.

2019-11-25 18:44:13 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:13 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rQVJZTmNLaGlMU201eEl1ZDNaa1NOWG45M1hhYkVUR3BmU1g3em5LLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a0FSWU5jS2hpTFNtNXhJdWQzWmtTTlhuOTNYYWJFVEdwZlNYN3puSyxwPTBKdjVFL2x6bUQySVhEUm11UXdaSXl2c2cycnlFa1R0RTh4QW9jQ2w1OFU9</response>

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

2019-11-25 18:44:13 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:13 | [Mutex] received everything.

2019-11-25 18:44:13 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:13 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:13 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Xb0pHUmFOS2l6T1ZibW9pS3dOa2ZWYlRGRWtmNEx5MGtab3c3RlVqLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:14 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V29KR1JhTktpek9WYm1vaUt3TmtmVmJURkVrZjRMeTBrWm93N0ZVaixwPUkrTFlqL09rQWUvTm5Zb1VobERNRTlEQjFRd3Y3eTlCdVlWczNsOFlDT2c9</response>

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

2019-11-25 18:44:14 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:14 | [Mutex] received everything.

2019-11-25 18:44:14 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:14 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:14 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HemUwNXc1bTJaaGxYRGZUS3Y3TlY4cGd5S0gxQVh0R3pma3VrRkpkLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:14 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R3plMDV3NW0yWmhsWERmVEt2N05WOHBneUtIMUFYdEd6Zmt1a0ZKZCxwPUc0Wk5WN0pLMFNlT0ZJYysvUmJxd0h0cjBUOGMva2htTVdRS2NEUTB2aFk9</response>

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

2019-11-25 18:44:14 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:14 | [Mutex] received everything.

2019-11-25 18:44:14 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-25 18:44:14 | user :: user_hjckgn0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10aFdoVnFLTm5RczZkaWVydUhEcnc1N0pKWllUcEk4TWJ4UmxYbmpoLHM9S3lpci9Udkp5OG1TVmc9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:14 | user :: user_hjckgn0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dGhXaFZxS05uUXM2ZGllcnVIRHJ3NTdKSlpZVHBJOE1ieFJsWG5qaCxwPVpQbkhrbUVVSzJLT1lGaUU5d0lJMlZaSVliRkwzeFIvL3NHZXZJL2dteFk9</response>

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

2019-11-25 18:44:16 | [Mutex] waiting for: [user]

2019-11-25 18:44:16 | [Mutex] received everything.

2019-11-25 18:44:16 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-25 18:44:16 |

2019-11-25 18:44:16 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 18:44:16 | ------------------------------------

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@401ff0bc

2019-11-25 18:44:16 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1c9780c5}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4ed816cf}, 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@4ae79bcc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@fe51cf4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@304097a4}, 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 18:44:16 PST 2019}}}}

2019-11-25 18:44:16 | [Mutex] waiting for: [registration]

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3ea0910d

2019-11-25 18:44:16 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4ed816cf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@4ae79bcc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@fe51cf4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@304097a4}, 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 18:44:16 PST 2019}}}}

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@48ef44ee

2019-11-25 18:44:16 | 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 18:44:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6fcae3bb}

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

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

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5b03b451

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@61917ec5

2019-11-25 18:44:16 | 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 18:44:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@53eb8e2d}

2019-11-25 18:44:16 | 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 18:44:16 | user :: null >> <iq to="localhost" id="OYV3AfCv1eIUYhHsgHqgWV5" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 18:44:16 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@dbc95b22}

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

2019-11-25 18:44:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6b8478d0}

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@2de3e8cd

2019-11-25 18:44:16 | user :: null >> <iq to="localhost" id="RCPKLxgM2eNJwoXWi03l4yr" type="set"><query xmlns="jabber:iq:register"><username>user_xmm2of0028</username><password>user_xmm2of0028</password><email>ea81c9cd-40df-4f39-9b5d-f91626c1bda1@localhost</email></query></iq>

2019-11-25 18:44:16 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c15dcba1}

2019-11-25 18:44:16 | user :: null << <iq from="localhost" id="RCPKLxgM2eNJwoXWi03l4yr" type="result" xmlns="jabber:client"/>

2019-11-25 18:44:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@476ecce2}

2019-11-25 18:44:16 | [Mutex] received everything.

2019-11-25 18:44:16 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 18:44:16 | 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;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6fcae3bb, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@53eb8e2d]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4ed816cf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@4ae79bcc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@fe51cf4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@304097a4}, 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 18:44:16 PST 2019}}}}

2019-11-25 18:44:16 | 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;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6fcae3bb, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@53eb8e2d]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4ed816cf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@4ae79bcc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@fe51cf4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@304097a4}, 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 18:44:16 PST 2019}}}}

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@487bb8c4

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@711be3

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@32662ea0

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@35efdd2

2019-11-25 18:44:16 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@16f6d8e5

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

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

2019-11-25 18:44:16 | user :: user_xmm2of0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ONm9vUzFFbjc2bjFEVkc4Rk9qRFdBUjhuQ2RnUEN4RU9reFlsU2VMLHM9dnJxdjFBZTA5UTJSSkE9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:16 | user :: user_xmm2of0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TjZvb1MxRW43Nm4xRFZHOEZPakRXQVI4bkNkZ1BDeEVPa3hZbFNlTCxwPUl3WFJ6RVZFUURKM3dkbnNQYk1tL1BWVG5Lem1kYWRabzJGanVoalZ1dWs9</response>

2019-11-25 18:44:16 | user :: user_xmm2of0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1oL3ZUcTVnTW5jcTRTcTRTWHhzRDhLaExha2pCZ25aUUlOK2FqQlNhdmo0PQ==</success>

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

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost >> <iq xmlns="jabber:client" id="HDQHoRamcQVkJArTYcSU9rW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost << <iq id="HDQHoRamcQVkJArTYcSU9rW" type="result" xmlns="jabber:client" to="user_xmm2of0028@localhost/993927746-tigase-20"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_xmm2of0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="qPoeCzhCAlIQ6fJQ6xfzbmN" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost/993927746-tigase-20 << <iq id="qPoeCzhCAlIQ6fJQ6xfzbmN" type="result" xmlns="jabber:client" to="user_xmm2of0028@localhost/993927746-tigase-20"/>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="sK7xdukPGMYZdO2pZ39iFMA" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost/993927746-tigase-20 << <enabled location="d4270859fb27" id="fa34aaec-db4c-49e9-8bd9-0b17dd947a94" max="60" xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost/993927746-tigase-20 >> <iq id="i30dUTU5bymcyr16yhAAAdF" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost/993927746-tigase-20 << <iq id="i30dUTU5bymcyr16yhAAAdF" type="result" xmlns="jabber:client" to="user_xmm2of0028@localhost/993927746-tigase-20"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 18:44:17 | Disconnecting

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

2019-11-25 18:44:17 | [Mutex] notify: [disconnected]

2019-11-25 18:44:17 | [Mutex] received everything.

2019-11-25 18:44:17 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CV3hTeUk1MmNwTDYwMUNZdUJLWmFWQkdURnlCVWpGYzFqVWxUNmJMLHM9dnJxdjFBZTA5UTJSSkE9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Qld4U3lJNTJjcEw2MDFDWXVCS1phVkJHVEZ5QlVqRmMxalVsVDZiTCxwPUFJdm5RUFdrdzBRVmdqRm9OMFM0Z09xekNjOWNaQ3ZXMWtUN3c4MUlmVVk9</response>

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

2019-11-25 18:44:17 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:17 | [Mutex] received everything.

2019-11-25 18:44:17 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:17 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LVGhVSjNWZVRadFV3ZlNRN1EyVTlEcVhXQnN0aFZCblJ5Zkg4MGhyLHM9dnJxdjFBZTA5UTJSSkE9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S1RoVUozVmVUWnRVd2ZTUTdRMlU5RHFYV0JzdGhWQm5SeWZIODBocixwPWVTTW9LeGMycTZ3MVZRaTVVUjgwazUvVWtUK1kzS2FFdGIraGJKK2VsRFk9</response>

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

2019-11-25 18:44:17 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:17 | [Mutex] notify: [event, disconnected]

2019-11-25 18:44:17 | [Mutex] received everything.

2019-11-25 18:44:17 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:17 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wYWdKRUtReWNMeGZlNU9mTk1oTjY1Q0JVNEtXeDduaVpvVXpLQVVPLHM9dnJxdjFBZTA5UTJSSkE9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MGFnSkVLUXljTHhmZTVPZk5NaE42NUNCVTRLV3g3bmlab1V6S0FVTyxwPSsyWTg5dzVYclZhMmNQb0NsV3BXcE5jRXpFa0RCOHBYRVVLYkVGZXlSN2c9</response>

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

2019-11-25 18:44:17 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:17 | [Mutex] received everything.

2019-11-25 18:44:17 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:17 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RU2NFdlBNaENZcWFCRFFkbXRIdDgyMmkwcmloYlhlOUFyNnFBV3JNLHM9dnJxdjFBZTA5UTJSSkE9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UVNjRXZQTWhDWXFhQkRRZG10SHQ4MjJpMHJpaGJYZTlBcjZxQVdyTSxwPVRSYURNdHJoUnRDSWR2ZnpoWURGQlJERHBvZGo0Q0Rxb29WYU5NeWduakU9</response>

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

2019-11-25 18:44:17 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:17 | [Mutex] received everything.

2019-11-25 18:44:17 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZNWlzV1VsMDFWRnVnU25QSGR2b0c0MXZyM0g2NWdOS0lRclNSOGp2LHM9dnJxdjFBZTA5UTJSSkE9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:17 | user :: user_xmm2of0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WTVpc1dVbDAxVkZ1Z1NuUEhkdm9HNDF2cjNINjVnTktJUXJTUjhqdixwPTZaNGNBMDVsZWFUYVBEWlB4Q2V6NVRBMmMxMGIwV2JFdGtHS3UvMHEvdTA9</response>

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

2019-11-25 18:44:19 | [Mutex] waiting for: [user]

2019-11-25 18:44:19 | [Mutex] received everything.

2019-11-25 18:44:19 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-25 18:44:19 |

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

2019-11-25 18:44:19 | ------------------------------------

2019-11-25 18:44:19 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@12f0bd4c

2019-11-25 18:44:19 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1c9780c5}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1c374162}, 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@1808d63c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5d0a4b59}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4a879769}, 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 18:44:19 PST 2019}}}}

2019-11-25 18:44:19 | [Mutex] waiting for: [registration]

2019-11-25 18:44:19 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6c9df30a

2019-11-25 18:44:19 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1c374162}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@1808d63c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5d0a4b59}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4a879769}, 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 18:44:19 PST 2019}}}}

2019-11-25 18:44:19 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@32fa7193

2019-11-25 18:44:19 | 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 18:44:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3d25b416}

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

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

2019-11-25 18:44:19 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4b6f5004

2019-11-25 18:44:19 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@48e9ffc0

2019-11-25 18:44:19 | 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 18:44:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@29fe79a7}

2019-11-25 18:44:19 | 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 18:44:19 | user :: null >> <iq to="localhost" id="UFKEyAkZ7iW38GMBrgWdBhB" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 18:44:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5a40d0a2}

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

2019-11-25 18:44:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@396bed8a}

2019-11-25 18:44:19 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@8b565d3

2019-11-25 18:44:19 | user :: null >> <iq to="localhost" id="gHO4ApiFsbnW8KEDpS6nMYm" type="set"><query xmlns="jabber:iq:register"><username>user_3anzrn0029</username><password>user_3anzrn0029</password><email>975bce41-2e4f-46c9-8ca6-460f303f6fc5@localhost</email></query></iq>

2019-11-25 18:44:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d6815997}

2019-11-25 18:44:20 | user :: null << <iq from="localhost" id="gHO4ApiFsbnW8KEDpS6nMYm" type="result" xmlns="jabber:client"/>

2019-11-25 18:44:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f259cfa}

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

2019-11-25 18:44:20 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 18:44:20 | 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;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3d25b416, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@29fe79a7]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1c374162}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@1808d63c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5d0a4b59}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4a879769}, 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 18:44:20 PST 2019}}}}

2019-11-25 18:44:20 | 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;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3d25b416, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@29fe79a7]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1c374162}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@1808d63c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5d0a4b59}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4a879769}, 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 18:44:20 PST 2019}}}}

2019-11-25 18:44:20 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@554ceff8

2019-11-25 18:44:20 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@33ad5f66

2019-11-25 18:44:20 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@10152f3d

2019-11-25 18:44:20 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@33f4b389

2019-11-25 18:44:20 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1f5b920

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

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

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

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

2019-11-25 18:44:20 | user :: user_3anzrn0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj02TkllRlVEbndDbmFiT1BOQWR1c2F5dUVsRG8yTWtIdjU0Z3VQdW1FY0ZJPQ==</success>

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

2019-11-25 18:44:20 | user :: user_3anzrn0029@localhost >> <iq xmlns="jabber:client" id="XabujLAwdsk4bBAAvbrVQLY" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-25 18:44:20 | user :: user_3anzrn0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="75UcJDlJsZqSeU3AfCv1eIU" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 18:44:20 | user :: user_3anzrn0029@localhost/993927746-tigase-21 << <iq id="75UcJDlJsZqSeU3AfCv1eIU" type="result" xmlns="jabber:client" to="user_3anzrn0029@localhost/993927746-tigase-21"/>

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

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

2019-11-25 18:44:20 | user :: user_3anzrn0029@localhost/993927746-tigase-21 >> <iq id="05QPGMYZdO2pZ39iFMAEKJW" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 18:44:20 | user :: user_3anzrn0029@localhost/993927746-tigase-21 << <enabled location="d4270859fb27" id="bc74e0b2-d9db-4b6e-9c54-0449a9411f8f" max="60" xmlns="urn:xmpp:sm:3" resume="true"/>

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

2019-11-25 18:44:20 | user :: user_3anzrn0029@localhost/993927746-tigase-21 << <iq id="05QPGMYZdO2pZ39iFMAEKJW" type="result" xmlns="jabber:client" to="user_3anzrn0029@localhost/993927746-tigase-21"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 18:44:20 | Disconnecting

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

2019-11-25 18:44:20 | [Mutex] notify: [disconnected]

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

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

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

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

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

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

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

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

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

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

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

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

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

2019-11-25 18:44:20 | user :: user_3anzrn0029@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 18:44:20 | user :: user_3anzrn0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfM2FuenJuMDAyOQAgLSAtIC0gLSAt</auth>

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

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

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

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

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

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

2019-11-25 18:44:20 | user :: user_3anzrn0029@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 18:44:20 | user :: user_3anzrn0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfM2FuenJuMDAyOQAgLSAtIC0gLSAt</auth>

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

2019-11-25 18:44:23 |

2019-11-25 18:44:23 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-25 18:44:23 | ------------------------------------

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@15476802

2019-11-25 18:44:23 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1c9780c5}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1b8084da}, 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@1fbf0372}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5abd8ee1}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7414facc}, 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 18:44:23 PST 2019}}}}

2019-11-25 18:44:23 | [Mutex] waiting for: [registration]

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6bad16c0

2019-11-25 18:44:23 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1b8084da}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@1fbf0372}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5abd8ee1}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7414facc}, 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 18:44:23 PST 2019}}}}

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@cee3c54

2019-11-25 18:44:23 | 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 18:44:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3a9271ae}

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

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

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@69033eaa

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@6a9b2e5c

2019-11-25 18:44:23 | 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 18:44:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@17eab3c7}

2019-11-25 18:44:23 | 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 18:44:23 | user :: null >> <iq to="localhost" id="HR49iFMAEKJWX2lHAqkOX3a" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 18:44:23 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@654648bf}

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

2019-11-25 18:44:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3edcaf95}

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@4eda308a

2019-11-25 18:44:23 | user :: null >> <iq to="localhost" id="yPWgWV5ywnVVTMDIsoeHSPM" type="set"><query xmlns="jabber:iq:register"><username>user_i9t06a0030</username><password>user_i9t06a0030</password><email>4dbe387d-5702-4da4-87f2-b9a8c866ca36@localhost</email></query></iq>

2019-11-25 18:44:23 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4897ceb}

2019-11-25 18:44:23 | user :: null << <iq from="localhost" id="yPWgWV5ywnVVTMDIsoeHSPM" type="result" xmlns="jabber:client"/>

2019-11-25 18:44:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7d800ec3}

2019-11-25 18:44:23 | [Mutex] received everything.

2019-11-25 18:44:23 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 18:44:23 | 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;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3a9271ae, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@17eab3c7]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1b8084da}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@1fbf0372}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5abd8ee1}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7414facc}, 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 18:44:23 PST 2019}}}}

2019-11-25 18:44:23 | 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;@1c9780c5}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3a9271ae, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@17eab3c7]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1b8084da}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@678e93ed}, 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@1fbf0372}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5abd8ee1}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7414facc}, 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 18:44:23 PST 2019}}}}

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3fb6fe3f

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@64cd5e5b

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7b8c7c28

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@607838c

2019-11-25 18:44:23 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@ec8d275

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

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

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11V3Nmd3NGVERzVjBVaThIb1EwOUxadk5RWGJ4OTZLcW1WY0plMUxMLHM9c3FUYXZqd2t4QWNKK3c9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dVdzZndzRlREc1YwVWk4SG9RMDlMWnZOUVhieDk2S3FtVmNKZTFMTCxwPVAvRHBkZWZKRFVBaUhaTFRneXRueit0ZHlTRml6ZUJiL2cwUGNaMDdFWW89</response>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1FVXJjTGMrdysrVEtkMHRxTncyK0xEaGVuYWFDa2k4UCtyQm9FR3dEdFB3PQ==</success>

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

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost >> <iq xmlns="jabber:client" id="UPUYcSU9rWeDi0qT1qgRTRL" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost << <iq id="UPUYcSU9rWeDi0qT1qgRTRL" type="result" xmlns="jabber:client" to="user_i9t06a0030@localhost/993927746-tigase-22"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_i9t06a0030@localhost/993927746-tigase-22</jid></bind></iq>

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

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-22 << <iq id="BS1fSaFv5dqViCISZsZ6tX6" type="result" xmlns="jabber:client" to="user_i9t06a0030@localhost/993927746-tigase-22"/>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="kklJArTYcSU9rWeDi0qT1qg" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-22 << <enabled location="d4270859fb27" id="3c62d310-f483-46b8-86b1-8017f0370e8c" max="60" xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-22 >> <iq id="FcVZ39iFMAEKJWX2lHAqkOX" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-22 << <iq id="FcVZ39iFMAEKJWX2lHAqkOX" type="result" xmlns="jabber:client" to="user_i9t06a0030@localhost/993927746-tigase-22"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 18:44:23 | Disconnecting

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

2019-11-25 18:44:23 | [Mutex] notify: [disconnected]

2019-11-25 18:44:23 | [Mutex] received everything.

2019-11-25 18:44:23 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oa3haclVWVks3U0lhbGtYTmNXb2trWXRFVlVzUWpqV1RTS1JJVm9WLHM9c3FUYXZqd2t4QWNKK3c9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aGt4WnJVVlZLN1NJYWxrWE5jV29ra1l0RVZVc1FqaldUU0tSSVZvVixwPURrODhXazhGT3hIMlliS0VaZGZwTVZTNzZKM3hackJab1VYUFQxcmlRb2M9</response>

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

2019-11-25 18:44:23 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:23 | [Mutex] received everything.

2019-11-25 18:44:23 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:23 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rNU91RkFXdTBSU01nTW8wOGY3cnozWHBubFdWQ29Tek1KZGJUWjFsLHM9c3FUYXZqd2t4QWNKK3c9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9azVPdUZBV3UwUlNNZ01vMDhmN3J6M1hwbmxXVkNvU3pNSmRiVFoxbCxwPS9HeGJLMXVvK05KY1NmOGZwZnBjQjdQYlBHU1NEdFU2bHJ3UTdxUkx1ZE09</response>

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

2019-11-25 18:44:23 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:23 | [Mutex] received everything.

2019-11-25 18:44:23 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 18:44:23 | [Mutex] waiting for: [event]

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

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

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14R1ZWQklhTDJta0VrN0gzV1JQcUNIYW9BZDRuQWptenZURHNVWXB3LHM9c3FUYXZqd2t4QWNKK3c9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eEdWVkJJYUwybWtFazdIM1dSUHFDSGFvQWQ0bkFqbXp2VERzVVlwdyxwPXdaaVRjcUFkSGEyd3J3eTRVMmsydUdPODRvRkMrUEU1QXlPaXpOVWMySWM9</response>

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

2019-11-25 18:44:23 | [Mutex] notify: [event, authFailed]

2019-11-25 18:44:23 | [Mutex] received everything.

2019-11-25 18:44:23 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13VWloVU5NZTY1VGRVbHJyb0JWWmJIaTlGM0p0czBxQzR3S3dIWFcxLHM9c3FUYXZqd2t4QWNKK3c9PSxpPTQwOTY=</challenge>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d1VpaFVOTWU2NVRkVWxycm9CVlpiSGk5RjNKdHMwcUM0d0t3SFhXMSxwPWs0cFU2SzQwZkQxQU5VeWswNjJYYlpudXErdGROU1pmN1VIcGR6VWdydDQ9</response>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1uVkowaHR5Y1FYZDllMUhJdzZremFDK3ZxVkNvZ1V0djJZL1JrQVlyTmtvPQ==</success>

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

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost >> <iq xmlns="jabber:client" id="MU1uq5EnS13iQaujLAwdsk4" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost << <iq id="MU1uq5EnS13iQaujLAwdsk4" type="result" xmlns="jabber:client" to="user_i9t06a0030@localhost/993927746-tigase-23"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_i9t06a0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="14tWi03l4yr3bpOHQIUgL05" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-23 << <iq id="14tWi03l4yr3bpOHQIUgL05" type="result" xmlns="jabber:client" to="user_i9t06a0030@localhost/993927746-tigase-23"/>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="nbMxgM2eNJwoXWi03l4yr3b" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-23 << <enabled location="d4270859fb27" id="8a261008-3aca-466e-b69c-918b87abf34c" max="60" xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 18:44:23 | user :: user_i9t06a0030@localhost/993927746-tigase-23 >> <iq id="AletbKU9t15apgyACtqVYdr" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-25 18:44:24 | user :: user_i9t06a0030@localhost/993927746-tigase-23 << <iq id="AletbKU9t15apgyACtqVYdr" type="result" xmlns="jabber:client" to="user_i9t06a0030@localhost/993927746-tigase-23"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 18:44:24 | Disconnecting

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

2019-11-25 18:44:24 | [Mutex] notify: [disconnected]

2019-11-25 18:44:24 | [Mutex] received everything.

2019-11-25 18:44:26 | [Mutex] waiting for: [user]

2019-11-25 18:44:26 | [Mutex] received everything.

2019-11-25 18:44:26 | [Mutex] isItemNotified: user:ok:true :: true