Brute Force Prevention

Test duration: 15.119s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.498s
2019-11-25 20:02:19 |

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

2019-11-25 20:02:19 | ------------------------------------

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@310c9792

2019-11-25 20:02:19 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@872a3b4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3fcb7fc3}, 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@3bf4fce2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7ef675f8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b93cdb3}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:19 PST 2019}}}}

2019-11-25 20:02:19 | [Mutex] waiting for: [registration]

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4fc28a65

2019-11-25 20:02:19 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3fcb7fc3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@3bf4fce2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7ef675f8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b93cdb3}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:19 PST 2019}}}}

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@534d6c93

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

2019-11-25 20:02:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ed98ab7}

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

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

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

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2b12328a

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7058142f

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

2019-11-25 20:02:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4849c743}

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

2019-11-25 20:02:19 | user :: null >> <iq to="localhost" id="mB4tj1qViXjCs7ycr7x9Ds3" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 20:02:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@bc12cbc1}

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

2019-11-25 20:02:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1a9770cf}

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@202b9775

2019-11-25 20:02:19 | user :: null >> <iq to="localhost" id="ayTaoWV0eJTQVlT9FJQLYj1" type="set"><query xmlns="jabber:iq:register"><username>user_iajiej0027</username><password>user_iajiej0027</password><email>ed64f992-486c-489b-8bb0-7f7702620a34@localhost</email></query></iq>

2019-11-25 20:02:19 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a84c3937}

2019-11-25 20:02:19 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="ayTaoWV0eJTQVlT9FJQLYj1"/>

2019-11-25 20:02:19 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@10620633}

2019-11-25 20:02:19 | [Mutex] received everything.

2019-11-25 20:02:19 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 20:02:19 | 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;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ed98ab7, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4849c743]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3fcb7fc3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@3bf4fce2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7ef675f8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b93cdb3}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:19 PST 2019}}}}

2019-11-25 20:02:19 | 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;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1ed98ab7, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4849c743]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3fcb7fc3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@3bf4fce2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7ef675f8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2b93cdb3}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:19 PST 2019}}}}

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1617b8a3

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@37a7b3a6

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4b4b1a18

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@4b98dedc

2019-11-25 20:02:19 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6061b5ac

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

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj02aFFORGNCZGdRQjFYMnVVNUFheA==</auth>

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02aFFORGNCZGdRQjFYMnVVNUFheGQ1V1AwS3c4RmhUNWkwZ0R6eERNLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NmhRTkRjQmRnUUIxWDJ1VTVBYXhkNVdQMEt3OEZoVDVpMGdEenhETSxwPVE0VlU5dm04V0VwYkxxSjdCSDJaS2tNM1dIS1NmaGR2dzFVRWtGVlQ5STg9</response>

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0xZmsvU3RCb2UwTmcrTi9kQnE1elkwTXFJNlg1R3ZBVVRuV2VyNTg1VUpvPQ==</success>

2019-11-25 20:02:19 | user :: user_iajiej0027@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" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU="/></features>

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost >> <iq xmlns="jabber:client" id="nNAvpcto9Ho0dKAdFDl1eBC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost/993927746-tigase-19 << <iq to="user_iajiej0027@localhost/993927746-tigase-19" type="result" xmlns="jabber:client" id="BGdHthKDGq03gKLXYbRVdNZ"/>

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

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

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost/993927746-tigase-19 << <enabled max="60" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="4b9adbd8-c475-4a6d-8291-c7d4be68bd86"/>

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost/993927746-tigase-19 >> <iq id="sVS5z8ubGsX9BhTY5AeChIE" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost/993927746-tigase-19 << <iq to="user_iajiej0027@localhost/993927746-tigase-19" from="localhost" type="result" xmlns="jabber:client" id="iTOExzl3tl4dS7DgKHIw5p7"><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 var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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 20:02:19 | user :: user_iajiej0027@localhost/993927746-tigase-19 << <iq to="user_iajiej0027@localhost/993927746-tigase-19" type="result" xmlns="jabber:client" id="sVS5z8ubGsX9BhTY5AeChIE"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:02:19 | Disconnecting

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

2019-11-25 20:02:19 | [Mutex] notify: [disconnected]

2019-11-25 20:02:19 | [Mutex] received everything.

2019-11-25 20:02:19 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1vbFZtdElXVXpTNkUyVDhuNGRwOA==</auth>

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vbFZtdElXVXpTNkUyVDhuNGRwOGc5OFV4VjJEbXdqQXgyQTJUZW1aLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b2xWbXRJV1V6UzZFMlQ4bjRkcDhnOThVeFYyRG13akF4MkEyVGVtWixwPWlpV0tPMjZwSjlnK0VNWDlwMWt5WDZqckpqbFgrOXc5RmdpUHRRbWtLY1E9</response>

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

2019-11-25 20:02:19 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:19 | [Mutex] received everything.

2019-11-25 20:02:19 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:19 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:19 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj11TU1Ib1NBd1VGR2gzMVA1aWFVdw==</auth>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11TU1Ib1NBd1VGR2gzMVA1aWFVd0Mzd01rdEZPdGRvTDdad1Y5V0tELHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dU1NSG9TQXdVRkdoMzFQNWlhVXdDM3dNa3RGT3Rkb0w3WndWOVdLRCxwPUdOVDd2UG1HbXQvZUxwb3ZDQzZGNS9pNWl4TkdpT25QdWJrV1F5WlhEZ3M9</response>

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

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

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

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

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

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj0zdTBZeUM2YmplUUxtSTRoV2RkdA==</auth>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zdTBZeUM2YmplUUxtSTRoV2RkdGozdW9UWjJnVHM4MFVhWVNvYWVFLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M3UwWXlDNmJqZVFMbUk0aFdkZHRqM3VvVFoyZ1RzODBVYVlTb2FlRSxwPXFDUkdnMEFzWEZrWmp1U0w0akVMcVhCMGZRYlVFWWt6OEltT0VYeG83bEU9</response>

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

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

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

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

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

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1uU2h5TGtwbkRtUTdGM2lRSG9tQw==</auth>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uU2h5TGtwbkRtUTdGM2lRSG9tQzVXUEdEbkNkNEY5cXNucmQ1ajdJLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9blNoeUxrcG5EbVE3RjNpUUhvbUM1V1BHRG5DZDRGOXFzbnJkNWo3SSxwPXJCdUYvNWNGWjhzL1BxOHJORTNTRngrRURyY05ybElveGp5YllsYUhCSkU9</response>

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

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

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

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

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

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

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj04MkpFYzRaY0o5WUxRMXhFRG5pVw==</auth>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04MkpFYzRaY0o5WUxRMXhFRG5pV1FCdVRkSUkxWVhlM3IwQ2FTRDA5LHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ODJKRWM0WmNKOVlMUTF4RURuaVdRQnVUZElJMVlYZTNyMENhU0QwOSxwPXlVY0NZQkgwc3piVklZWEJjU2traTArWHNXekYwc2phNG8xRFhNcVRiNk09</response>

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

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

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

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

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

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

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1rWlE3djZtREhZRWRKOHk1MHJLMg==</auth>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rWlE3djZtREhZRWRKOHk1MHJLMlNOQlc3V1MxUVhITXlVb3pSaUZtLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a1pRN3Y2bURIWUVkSjh5NTBySzJTTkJXN1dTMVFYSE15VW96UmlGbSxwPXhYbzlPSThOb25YVnlPaHZjam0xYkR5aXhkcFFOQ0dIb1pGemVjbW8zNDg9</response>

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

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

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

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

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

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1vcmtIRjNGWGhpTGNTNDI3OWdtag==</auth>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vcmtIRjNGWGhpTGNTNDI3OWdtak83ZDU2andtSUN4TUVjSmtIWHI5LHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b3JrSEYzRlhoaUxjUzQyNzlnbWpPN2Q1Nmp3bUlDeE1FY0prSFhyOSxwPVVxQWk3dk5KVitHTU9NQ2F3dEZCVWZHZ05ZNUxhZ0N2dTVhVTF0ZWJ1TTQ9</response>

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

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

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

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

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

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj02cVZBSjlqNHNEaTBOYkpzVlpxVw==</auth>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02cVZBSjlqNHNEaTBOYkpzVlpxV0NWQ3kyaG03TzA4RlN0YWlDVEt3LHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NnFWQUo5ajRzRGkwTmJKc1ZacVdDVkN5MmhtN08wOEZTdGFpQ1RLdyxwPWZ1VEJIOTd4b2tCRGJ0aDlpdTg3bFN5eHdvVmRuVXcyZldDL1VBWjJ5WW89</response>

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

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

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

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

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

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

2019-11-25 20:02:20 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1Gd0p1OVduTGk4RVRmOGRCeHZHTw==</auth>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Gd0p1OVduTGk4RVRmOGRCeHZHT1p5Njd4ckNBSjNkNFZMUVdQRVBFLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RndKdTlXbkxpOEVUZjhkQnh2R09aeTY3eHJDQUozZDRWTFFXUEVQRSxwPTNrL3Azd1ZCSnorUkU5QW5LTDMwdnBpWGN0T05qV3FlQk9uV1E2WW1wMU09</response>

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

2019-11-25 20:02:21 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:21 | [Mutex] received everything.

2019-11-25 20:02:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:21 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1QaTh6TFBQS1VDVE82OUR5a0JLdQ==</auth>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QaTh6TFBQS1VDVE82OUR5a0JLdVpBOTIwNGJmYmdra3B2SVdOVWhpLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UGk4ekxQUEtVQ1RPNjlEeWtCS3VaQTkyMDRiZmJna2twdklXTlVoaSxwPUhQaDVhaHM2czZ0SzhBd2VSODNEc3FFc3dLRFV4SERLYllNQmY1cFdoMDg9</response>

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

2019-11-25 20:02:21 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:21 | [Mutex] received everything.

2019-11-25 20:02:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:21 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1INXZYVWRxR2xyc0pxOGpINE9qNw==</auth>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1INXZYVWRxR2xyc0pxOGpINE9qN042VnJrUkQ5YnNPNmFIUVZGdVNWLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SDV2WFVkcUdscnNKcThqSDRPajdONlZya1JEOWJzTzZhSFFWRnVTVixwPUFiTzY1ZEtjbk5mdWwwaHdHbzlTb2hud0JJY2UxdFozay8wZDlsUzhhd289</response>

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

2019-11-25 20:02:21 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:21 | [Mutex] received everything.

2019-11-25 20:02:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:21 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1sT0d2ekhVOTVWZ0dta1JvMWFDdQ==</auth>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sT0d2ekhVOTVWZ0dta1JvMWFDdTh5Q2xRYVBvOVp4Z3Y4bW1MTElaLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bE9HdnpIVTk1VmdHbWtSbzFhQ3U4eUNsUWFQbzlaeGd2OG1tTExJWixwPURUbWMwNGZwMkRBOWdOTERtMFdCS3BTdU1XWWMrekd6VFJDTVFTWFFReHc9</response>

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

2019-11-25 20:02:21 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:21 | [Mutex] received everything.

2019-11-25 20:02:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:21 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj03MHVaRjlROExET1d1cTNmUHlieQ==</auth>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03MHVaRjlROExET1d1cTNmUHlieXlUdkdyb0Zld2Z2M1lZUGpVUVdvLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NzB1WkY5UThMRE9XdXEzZlB5Ynl5VHZHcm9GZXdmdjNZWVBqVVFXbyxwPStHaWd2c0xvNXQvUlFxVGk3QWJZUk5BbEt6Z2kyU3RFOE9MVUdtV3pkUDQ9</response>

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

2019-11-25 20:02:21 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:21 | [Mutex] received everything.

2019-11-25 20:02:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:21 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1PQm1ibU1lQU9MR0RwUlV0RnZsTg==</auth>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PQm1ibU1lQU9MR0RwUlV0RnZsTkdLWEVJYWVjU1hVYlhSdjJlRzdJLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T0JtYm1NZUFPTEdEcFJVdEZ2bE5HS1hFSWFlY1NYVWJYUnYyZUc3SSxwPTR2UXdWRlpDeWMzM0NlT00xdzArQjhlQzE1MVpiTU5aZ25uTi9YN0tHSjg9</response>

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

2019-11-25 20:02:21 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:21 | [Mutex] received everything.

2019-11-25 20:02:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:21 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1CMzU5bnFhQlNUQWZaMjdxVDNDUA==</auth>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CMzU5bnFhQlNUQWZaMjdxVDNDUGd4VEtPQXM4Q0NuTzU0bWtqZmZhLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QjM1OW5xYUJTVEFmWjI3cVQzQ1BneFRLT0FzOENDbk81NG1ramZmYSxwPXc2dGVVcUVSc3BqdHE2SDdqMW9lU0pzV0VLbjRFNHlTOGVLZVZwSURha0k9</response>

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

2019-11-25 20:02:21 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:21 | [Mutex] received everything.

2019-11-25 20:02:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:21 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1kT0dmcHQyamZlbE1PeXpUcEpvZQ==</auth>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kT0dmcHQyamZlbE1PeXpUcEpvZUF0WXl6Zmdoc1MzelJ0OFl0a2VqLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZE9HZnB0MmpmZWxNT3l6VHBKb2VBdFl5emZnaHNTM3pSdDhZdGtlaixwPWZXZ2MyTWFXeWFZa0RZNXlNMWlkd1NLYjlzSTVIY1N0dzdBeTF0OWFSUjg9</response>

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

2019-11-25 20:02:21 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:21 | [Mutex] notify: [event, disconnected]

2019-11-25 20:02:21 | [Mutex] received everything.

2019-11-25 20:02:21 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:21 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:21 | user :: user_iajiej0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1pOXMyS1Y0ank0V0JxQmhOWWF6ZA==</auth>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pOXMyS1Y0ank0V0JxQmhOWWF6ZG5HWWQ0WGxzQkhLOXpjTEVrOElvLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aTlzMktWNGp5NFdCcUJoTllhemRuR1lkNFhsc0JISzl6Y0xFazhJbyxwPTlXZmdqZ0MzaldxR29ZbUE0cXcwOEE5MXZtY2ZXbWMrZ0xLeEtMSUhTYm89</response>

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

2019-11-25 20:02:22 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:22 | [Mutex] received everything.

2019-11-25 20:02:22 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:22 | [Mutex] waiting for: [event]

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

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

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

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1WN2JHMk1WOFFUNGhaODFYMFhiRg==</auth>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WN2JHMk1WOFFUNGhaODFYMFhiRmtubWxXQjN0ekJBQTJwZUhSYm01LHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VjdiRzJNVjhRVDRoWjgxWDBYYkZrbm1sV0IzdHpCQUEycGVIUmJtNSxwPU9MMTVFblRpWTgxVHZqaCtmSEdJRTJWKzF2M1N5KzNnK015S1BjYUNLd1U9</response>

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

2019-11-25 20:02:22 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:22 | [Mutex] received everything.

2019-11-25 20:02:22 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:22 | [Mutex] waiting for: [event]

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

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

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

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1QckJDaXJ2dU0ybEdNTVhBOWlVMA==</auth>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QckJDaXJ2dU0ybEdNTVhBOWlVMExqaGpROFdoOTJQU0FrYTdMdFNGLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UHJCQ2lydnVNMmxHTU1YQTlpVTBMamhqUThXaDkyUFNBa2E3THRTRixwPVNYM01USXNvQUNBZE16a25uaXdFVlFpR1Z2Y0VGZHNvUHdLZlhyWGhQeGM9</response>

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

2019-11-25 20:02:22 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:22 | [Mutex] received everything.

2019-11-25 20:02:22 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:22 | [Mutex] waiting for: [event]

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

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

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

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1nWFdNZU9acERiOG1tR2lNeWhUTA==</auth>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nWFdNZU9acERiOG1tR2lNeWhUTHVDSEVsd0N4eFZCN1N3MzZTR0U3LHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z1hXTWVPWnBEYjhtbUdpTXloVEx1Q0hFbHdDeHhWQjdTdzM2U0dFNyxwPUJNUUczcEhtVXE0dW5MbUJoYUo5bFJueDYrYllNSTc5S2NzUCtCa0FsTWc9</response>

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

2019-11-25 20:02:22 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:22 | [Mutex] received everything.

2019-11-25 20:02:22 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:22 | [Mutex] waiting for: [event]

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

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

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

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj05SU1KUDRGd3JSUHJsZlFPS1ZKYw==</auth>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05SU1KUDRGd3JSUHJsZlFPS1ZKYzdrMEgxOGMzbkpUMFJ1OHJyMzNPLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OUlNSlA0RndyUlBybGZRT0tWSmM3azBIMThjM25KVDBSdThycjMzTyxwPXlidjA2cDhTK3luL0xMbG9EOUxQbXdVR2V1N3EyL28waHd3bDdPbjRJQlE9</response>

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

2019-11-25 20:02:22 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:22 | [Mutex] received everything.

2019-11-25 20:02:22 | [Mutex] isItemNotified: authFailed :: true

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

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

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

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2lhamllajAwMjcscj1RbWFROEJweXhQRmJlMHpiQ0h3SQ==</auth>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RbWFROEJweXhQRmJlMHpiQ0h3SVFFSjR4RXdoUmFEWG40ODlINXpVLHM9L09tZDhmdWN2ZXh2d1E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:22 | user :: user_iajiej0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UW1hUThCcHl4UEZiZTB6YkNId0lRRUo0eEV3aFJhRFhuNDg5SDV6VSxwPUdxa3RGUCtQYkxpWE95cjArRjRrakZQTHZua2JWOUpMc0o0NE0yK2V4bTA9</response>

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

2019-11-25 20:02:24 | [Mutex] waiting for: [user]

2019-11-25 20:02:24 | [Mutex] received everything.

2019-11-25 20:02:24 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.279s
2019-11-25 20:02:24 |

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

2019-11-25 20:02:24 | ------------------------------------

2019-11-25 20:02:24 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@114ff5ba

2019-11-25 20:02:24 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@872a3b4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1f8819e3}, 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@1bb79eca}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5eb513d8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@30b9df91}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:24 PST 2019}}}}

2019-11-25 20:02:24 | [Mutex] waiting for: [registration]

2019-11-25 20:02:24 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6fa18f64

2019-11-25 20:02:24 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1f8819e3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@1bb79eca}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5eb513d8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@30b9df91}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:24 PST 2019}}}}

2019-11-25 20:02:24 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@48471d94

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

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

2019-11-25 20:02:24 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3e9aec97}

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

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

2019-11-25 20:02:24 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@40a1e982

2019-11-25 20:02:24 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2398845d

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

2019-11-25 20:02:24 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@53439607}

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

2019-11-25 20:02:24 | user :: null >> <iq to="localhost" id="7BOV2dQKElQU5BgL1fR5zw7" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 20:02:24 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d3d04da1}

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

2019-11-25 20:02:24 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3ad436ac}

2019-11-25 20:02:24 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@75f6258d

2019-11-25 20:02:24 | user :: null >> <iq to="localhost" id="UUHLUTeP36q3qWV5t1nW1sY" type="set"><query xmlns="jabber:iq:register"><username>user_gxqpt00028</username><password>user_gxqpt00028</password><email>1307f3d4-8ccc-45ca-9c75-636247333b9b@localhost</email></query></iq>

2019-11-25 20:02:24 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@bbb4b4ff}

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

2019-11-25 20:02:25 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@12abed02}

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

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

2019-11-25 20:02:25 | 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;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3e9aec97, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@53439607]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1f8819e3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@1bb79eca}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5eb513d8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@30b9df91}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:25 PST 2019}}}}

2019-11-25 20:02:25 | 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;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3e9aec97, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@53439607]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1f8819e3}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@1bb79eca}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5eb513d8}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@30b9df91}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:25 PST 2019}}}}

2019-11-25 20:02:25 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5d17b2fe

2019-11-25 20:02:25 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@46ed8ea6

2019-11-25 20:02:25 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@27301bb

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

2019-11-25 20:02:25 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4ffd2f0a

2019-11-25 20:02:25 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2f9df449

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d4cXB0MDAwMjgscj1kbjF6M0Q1RnkzdEtBUEpvSThiUA==</auth>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kbjF6M0Q1RnkzdEtBUEpvSThiUG92TjNiMzdHZWozN0pkeU5Fck9JLHM9OWZMcTcvcDNyTnlUa0E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZG4xejNENUZ5M3RLQVBKb0k4YlBvdk4zYjM3R2VqMzdKZHlORXJPSSxwPVFmdUkzZm11UVRWZFU5clJpbkk3NElkRE1sVFdvQ3p0eGRkdTFjeTI4L0U9</response>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1OOEU2d1RHNndiQktBbk03dDZTSnNaUmxDOFA4dnF1NkVid2ZuQ1BDNG1zPQ==</success>

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

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

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

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost/993927746-tigase-20 << <iq to="user_gxqpt00028@localhost/993927746-tigase-20" type="result" xmlns="jabber:client" id="tWJPEwfOItbFp9u7EmSNKIH"/>

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

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost/993927746-tigase-20 << <enabled max="60" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="b46ca938-b2a8-42cb-99fa-0daf080c2350"/>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost/993927746-tigase-20 >> <iq id="eENIEzzcDLJP1rgBEFJs8tg" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost/993927746-tigase-20 << <iq to="user_gxqpt00028@localhost/993927746-tigase-20" from="localhost" type="result" xmlns="jabber:client" id="ZXKRIEvkKxjVVbyfUSURSYd"><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 var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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 20:02:25 | user :: user_gxqpt00028@localhost/993927746-tigase-20 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost/993927746-tigase-20 << <iq to="user_gxqpt00028@localhost/993927746-tigase-20" type="result" xmlns="jabber:client" id="eENIEzzcDLJP1rgBEFJs8tg"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:02:25 | Disconnecting

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

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

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

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

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d4cXB0MDAwMjgscj10Y01zT0Z0YWVLdE5zSzByYnFIVw==</auth>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10Y01zT0Z0YWVLdE5zSzByYnFIV1RIU1owbldRQ2U5azdqdFJSUGJULHM9OWZMcTcvcDNyTnlUa0E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dGNNc09GdGFlS3ROc0swcmJxSFdUSFNaMG5XUUNlOWs3anRSUlBiVCxwPUVVQmNTbUx1UmxabHBrcHdjYkRaOVQwMjBKYTFialNjc0RuSlc3Z0J6YTQ9</response>

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

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

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

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

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

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d4cXB0MDAwMjgscj05WjN0ZDJtS1gwZ25wZ3RGOUpqcA==</auth>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05WjN0ZDJtS1gwZ25wZ3RGOUpqcFN1alpsVDBmN05RZHdVUEkzTUx2LHM9OWZMcTcvcDNyTnlUa0E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OVozdGQybUtYMGducGd0RjlKanBTdWpabFQwZjdOUWR3VVBJM01MdixwPWFEakRXMllpNHFIVk1iNGVHVkdiOWtacVBUYmxXeGhqVnFwODJjcHdYMEE9</response>

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

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

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

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

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

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d4cXB0MDAwMjgscj1zejE3T0hLMkZpWlpHNW5YaEFXeA==</auth>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zejE3T0hLMkZpWlpHNW5YaEFXeGFzZWNZSzl4TWh6VFJReUgyT1ptLHM9OWZMcTcvcDNyTnlUa0E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c3oxN09ISzJGaVpaRzVuWGhBV3hhc2VjWUs5eE1oelRSUXlIMk9abSxwPUdQZ0NuTUZqSlZOTzVCN1NHSllDT05pSzFlT1o3M1BFZ3BJSlF5UWJZL3c9</response>

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

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

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

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

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

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d4cXB0MDAwMjgscj1LR0x0TjZJRzEwd0JReGZjQzU1Zw==</auth>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LR0x0TjZJRzEwd0JReGZjQzU1Z1AzTktnMHpVWTVxSGRpeE1SNnFELHM9OWZMcTcvcDNyTnlUa0E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S0dMdE42SUcxMHdCUXhmY0M1NWdQM05LZzB6VVk1cUhkaXhNUjZxRCxwPTY4aUFWYUpVUzNieG1tWEFLMFFteTJOUXFhc3VLRVNRQXpQSUYxeHlSeGc9</response>

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

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

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

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

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

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

2019-11-25 20:02:25 | user :: user_gxqpt00028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:26 | user :: user_gxqpt00028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2d4cXB0MDAwMjgscj10Vm1IdjFrdG5DeE5ic3lmcEtxYg==</auth>

2019-11-25 20:02:26 | user :: user_gxqpt00028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10Vm1IdjFrdG5DeE5ic3lmcEtxYmtsbWdyRkdnODJxT0VEaXNOdFN4LHM9OWZMcTcvcDNyTnlUa0E9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:26 | user :: user_gxqpt00028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFZtSHYxa3RuQ3hOYnN5ZnBLcWJrbG1nckZHZzgycU9FRGlzTnRTeCxwPUZhTUdOK3NSZzd3UVVyWEFFVGJaTlBqUkJaQjhMaU5qRzlpcyt0M25qODg9</response>

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

2019-11-25 20:02:28 | [Mutex] waiting for: [user]

2019-11-25 20:02:28 | [Mutex] received everything.

2019-11-25 20:02:28 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 2.999s
2019-11-25 20:02:28 |

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

2019-11-25 20:02:28 | ------------------------------------

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5d663a54

2019-11-25 20:02:28 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@872a3b4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@53a1cf88}, 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@579e5124}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@129cc5b3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7e44f92e}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:28 PST 2019}}}}

2019-11-25 20:02:28 | [Mutex] waiting for: [registration]

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2344b4e1

2019-11-25 20:02:28 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@53a1cf88}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@579e5124}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@129cc5b3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7e44f92e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:28 PST 2019}}}}

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@676d6dc

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

2019-11-25 20:02:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@72b33afc}

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

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

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

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2be7300d

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2d027a2c

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

2019-11-25 20:02:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d729966}

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

2019-11-25 20:02:28 | user :: null >> <iq to="localhost" id="zKZZdJxp09Iu8jMMP5eHTZl" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 20:02:28 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6d0c0ae0}

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

2019-11-25 20:02:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@76fd24ee}

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@64080564

2019-11-25 20:02:28 | user :: null >> <iq to="localhost" id="cJUWV0eJTQVlT9FJQLYj12i" type="set"><query xmlns="jabber:iq:register"><username>user_so9dg10029</username><password>user_so9dg10029</password><email>17c2950e-0cbb-4b4a-8182-0615a277eb78@localhost</email></query></iq>

2019-11-25 20:02:28 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3fea3606}

2019-11-25 20:02:28 | [Mutex] received everything.

2019-11-25 20:02:28 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 20:02:28 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="cJUWV0eJTQVlT9FJQLYj12i"/>

2019-11-25 20:02:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5a65c0d3}

2019-11-25 20:02:28 | 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;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@72b33afc, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d729966]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@53a1cf88}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@579e5124}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@129cc5b3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7e44f92e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:28 PST 2019}}}}

2019-11-25 20:02:28 | 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;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@72b33afc, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1d729966]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@53a1cf88}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@579e5124}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@129cc5b3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7e44f92e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:28 PST 2019}}}}

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5355cb50

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@4c904f80

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@68974053

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1c0076ca

2019-11-25 20:02:28 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@61f22151

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3NvOWRnMTAwMjkscj0wY2lwUUR5d1E2eXdzWWRmeThWUw==</auth>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wY2lwUUR5d1E2eXdzWWRmeThWU0ZHbWlhVVp2ZkRpcVdMcXA5S01HLHM9eTFpSS9pSTBqTVl6SHc9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MGNpcFFEeXdRNnl3c1lkZnk4VlNGR21pYVVadmZEaXFXTHFwOUtNRyxwPTlUT3Ftb0o1SFlLNzJTaHU4Q3Urd05XZGJadXNvTGwzaXJxSXFxV3FYVzg9</response>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1sTkNlbEdGaVNiUDRXUWh3ZDlPZnV3YVdXU1hTcHBFNDJQWDYwSS9sQis4PQ==</success>

2019-11-25 20:02:28 | user :: user_so9dg10029@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" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU="/></features>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <iq xmlns="jabber:client" id="jKV3BpbJR6h0n9iOPY27tfz" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost/993927746-tigase-21 << <iq to="user_so9dg10029@localhost/993927746-tigase-21" type="result" xmlns="jabber:client" id="DMZhKDGq03gKLXYbRVdNZmN"/>

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

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost/993927746-tigase-21 << <enabled max="60" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="176f2dcf-fe9e-4eba-ac65-8e640a437c89"/>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost/993927746-tigase-21 >> <iq id="84NKDGq03gKLXYbRVdNZmN2" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost/993927746-tigase-21 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost/993927746-tigase-21 << <iq to="user_so9dg10029@localhost/993927746-tigase-21" from="localhost" type="result" xmlns="jabber:client" id="NZAzcDLJP1rgBEFJs8tgChN"><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 var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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 20:02:28 | user :: user_so9dg10029@localhost/993927746-tigase-21 << <iq to="user_so9dg10029@localhost/993927746-tigase-21" type="result" xmlns="jabber:client" id="84NKDGq03gKLXYbRVdNZmN2"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:02:28 | Disconnecting

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

2019-11-25 20:02:28 | [Mutex] notify: [disconnected]

2019-11-25 20:02:28 | [Mutex] received everything.

2019-11-25 20:02:28 | [Mutex] waiting for: [event]

2019-11-25 20:02:28 | [Mutex] notify: [disconnected]

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3NvOWRnMTAwMjkscj1yMTQ5S0lpRXd2dGNlMHhTdVdnMw==</auth>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yMTQ5S0lpRXd2dGNlMHhTdVdnM3B3MmpTcTN2YjVnNXFpeVJJa0tmLHM9eTFpSS9pSTBqTVl6SHc9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cjE0OUtJaUV3dnRjZTB4U3VXZzNwdzJqU3EzdmI1ZzVxaXlSSWtLZixwPUNJZjA0b1N5NWxlME4vUnRTOUJxa2NJUFVKMFM3VVFZVzBROURFQnhMOTg9</response>

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

2019-11-25 20:02:28 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:28 | [Mutex] notify: [event, disconnected]

2019-11-25 20:02:28 | [Mutex] received everything.

2019-11-25 20:02:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:28 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfc285ZGcxMDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-25 20:02:28 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:28 | [Mutex] received everything.

2019-11-25 20:02:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:28 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3NvOWRnMTAwMjkscj1Ic3RPa0thYThnN0lNNUR3dU56eA==</auth>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Ic3RPa0thYThnN0lNNUR3dU56eGlUYjhTT1JnQzJPVXZJVm9XRU5MLHM9c0NsK0tzalRlZXhhTXc9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SHN0T2tLYWE4ZzdJTTVEd3VOenhpVGI4U09SZ0MyT1V2SVZvV0VOTCxwPTFKQ1l6UklkOFlTZkdvODloVmx4VkdTMkFTdz0=</response>

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

2019-11-25 20:02:28 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:28 | [Mutex] received everything.

2019-11-25 20:02:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:28 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX3NvOWRnMTAwMjkscj1vZjdwTVhwUnBocVhwN0JDNmltcA==</auth>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vZjdwTVhwUnBocVhwN0JDNmltcHhRM3dxVzNmUWs5bHhaajI4d1lXLHM9c0NsK0tzalRlZXhhTXc9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b2Y3cE1YcFJwaHFYcDdCQzZpbXB4UTN3cVczZlFrOWx4WmoyOHdZVyxwPWN3ZWd1bGxKTmlTZFJkWC9ld00wa3hkQmVIST0=</response>

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

2019-11-25 20:02:28 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:28 | [Mutex] received everything.

2019-11-25 20:02:28 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-25 20:02:28 | user :: user_so9dg10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:29 | user :: user_so9dg10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3NvOWRnMTAwMjkscj1CQ2lYVGVCUEVlbmZmdHBJaktxdA==</auth>

2019-11-25 20:02:29 | user :: user_so9dg10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CQ2lYVGVCUEVlbmZmdHBJaktxdG83VDBCVjFMVFB0TW9uaURoaWV0LHM9eTFpSS9pSTBqTVl6SHc9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:29 | user :: user_so9dg10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QkNpWFRlQlBFZW5mZnRwSWpLcXRvN1QwQlYxTFRQdE1vbmlEaGlldCxwPUZPYWEvUE9ucE5QbThaWmRwbGt1bkUwRTFkUEQrQ243aDR4d3VpZDFGN1k9</response>

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

2019-11-25 20:02:31 | [Mutex] waiting for: [user]

2019-11-25 20:02:31 | [Mutex] received everything.

2019-11-25 20:02:31 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.071s
2019-11-25 20:02:31 |

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

2019-11-25 20:02:31 | ------------------------------------

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@74c00afa

2019-11-25 20:02:31 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@872a3b4}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7a07ea12}, 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@7e38618a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b3ae029}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f59aa6e}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:31 PST 2019}}}}

2019-11-25 20:02:31 | [Mutex] waiting for: [registration]

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@a4b9eed

2019-11-25 20:02:31 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7a07ea12}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@7e38618a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b3ae029}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f59aa6e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:31 PST 2019}}}}

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@37c28a1f

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

2019-11-25 20:02:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5b151f66}

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

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

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

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@591dd4b0

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@f778588

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

2019-11-25 20:02:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2cc6640b}

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

2019-11-25 20:02:31 | user :: null >> <iq to="localhost" id="zS7fJLBxgFKygziOTdudV3t" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 20:02:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5bcdfab6}

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

2019-11-25 20:02:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5f5ba0da}

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@68d447d5

2019-11-25 20:02:31 | user :: null >> <iq to="localhost" id="LXkQXlKJX7BzxsZqdPEwfOI" type="set"><query xmlns="jabber:iq:register"><username>user_lb79pm0030</username><password>user_lb79pm0030</password><email>00e2226b-0c81-475d-be9d-691f89443b46@localhost</email></query></iq>

2019-11-25 20:02:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a0c7842f}

2019-11-25 20:02:31 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="LXkQXlKJX7BzxsZqdPEwfOI"/>

2019-11-25 20:02:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5b3cd482}

2019-11-25 20:02:31 | [Mutex] received everything.

2019-11-25 20:02:31 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 20:02:31 | 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;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5b151f66, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2cc6640b]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7a07ea12}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@7e38618a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b3ae029}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f59aa6e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:31 PST 2019}}}}

2019-11-25 20:02:31 | 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;@872a3b4}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5b151f66, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2cc6640b]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7a07ea12}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@494fa98f}, 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@7e38618a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b3ae029}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f59aa6e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 20:02:31 PST 2019}}}}

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@44c515d2

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@461a20e0

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@c3a2d19

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@319f60d8

2019-11-25 20:02:31 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@5d1898bc

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2xiNzlwbTAwMzAscj1IV2x6TFRSd2U1WkhMNHpaendJWQ==</auth>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IV2x6TFRSd2U1WkhMNHpaendJWW9WdXp0NWt1NVk4RjBiZ2ZIME93LHM9TVlvWmpONnRyMFI3RHc9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SFdsekxUUndlNVpITDR6Wnp3SVlvVnV6dDVrdTVZOEYwYmdmSDBPdyxwPXhDaFR3dUt4QWhaYW50Z1p4VXZDMWhmNUtPSTZoVE5BRTc5UXRmV1Q5VlU9</response>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0vZEE5TVNvUjhqVXYxYzZzYmcyVUg0c2FzUlF3czdXbHBBT1c2NTdJaVBRPQ==</success>

2019-11-25 20:02:31 | user :: user_lb79pm0030@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" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU="/></features>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <iq xmlns="jabber:client" id="90rZoQQJCsbNExzl3tl4dS7" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost << <iq to="user_lb79pm0030@localhost/993927746-tigase-22" type="result" xmlns="jabber:client" id="90rZoQQJCsbNExzl3tl4dS7"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_lb79pm0030@localhost/993927746-tigase-22</jid></bind></iq>

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost/993927746-tigase-22 << <iq to="user_lb79pm0030@localhost/993927746-tigase-22" type="result" xmlns="jabber:client" id="Q4BFxrfTapgTbmW5u4bBv5v"/>

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

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost/993927746-tigase-22 << <enabled max="60" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="8e57f4e1-143d-4892-a34b-d301a6579c40"/>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost/993927746-tigase-22 >> <iq id="L1oYdRMN5n7BBAfWfTMMLQM" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost/993927746-tigase-22 << <iq to="user_lb79pm0030@localhost/993927746-tigase-22" from="localhost" type="result" xmlns="jabber:client" id="uf6ayjWYZdJxp09Iu8jMMP5"><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 var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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 20:02:31 | user :: user_lb79pm0030@localhost/993927746-tigase-22 << <iq to="user_lb79pm0030@localhost/993927746-tigase-22" type="result" xmlns="jabber:client" id="L1oYdRMN5n7BBAfWfTMMLQM"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:02:31 | Disconnecting

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

2019-11-25 20:02:31 | [Mutex] notify: [disconnected]

2019-11-25 20:02:31 | [Mutex] received everything.

2019-11-25 20:02:31 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2xiNzlwbTAwMzAscj14V09CaFhmbU5rc3p0OHQyMWNVNA==</auth>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14V09CaFhmbU5rc3p0OHQyMWNVNFFnaWZlVG1yRjRzcWhhNXZMbjZpLHM9TVlvWmpONnRyMFI3RHc9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eFdPQmhYZm1Oa3N6dDh0MjFjVTRRZ2lmZVRtckY0c3FoYTV2TG42aSxwPTNlb01uT0Y4M2JQcnc5d0dnelVrWjU0TzJKVlNQV2JVdTlQVHRFRHNDbHM9</response>

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

2019-11-25 20:02:31 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:31 | [Mutex] received everything.

2019-11-25 20:02:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:31 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2xiNzlwbTAwMzAscj15S1c1ZUlDQ3Q0MTd3Tm5wc014UQ==</auth>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15S1c1ZUlDQ3Q0MTd3Tm5wc014UTY4QVd1N2pZQVFoeHRGUWVGY3BMLHM9TVlvWmpONnRyMFI3RHc9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eUtXNWVJQ0N0NDE3d05ucHNNeFE2OEFXdTdqWUFRaHh0RlFlRmNwTCxwPTFiUTdsQjJGdXNWNnNjdktUb0taNjU3NUxIKzdqZC9LbXU2b0dmeG1yVnc9</response>

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

2019-11-25 20:02:31 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:31 | [Mutex] received everything.

2019-11-25 20:02:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-25 20:02:31 | [Mutex] waiting for: [event]

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2xiNzlwbTAwMzAscj1GR2k1MktScDhTblBNY1A4RngzYg==</auth>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GR2k1MktScDhTblBNY1A4RngzYndjaUk3WnZOMW41NEdXcHJiUDUzLHM9TVlvWmpONnRyMFI3RHc9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:31 | user :: user_lb79pm0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RkdpNTJLUnA4U25QTWNQOEZ4M2J3Y2lJN1p2TjFuNTRHV3ByYlA1MyxwPWdCVmg5MjhCdW4zc1hUbXZiSXBFMmIrL0d5c2x3QkNubmZ3UVU1Ui92ZXM9</response>

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

2019-11-25 20:02:31 | [Mutex] notify: [event, authFailed]

2019-11-25 20:02:31 | [Mutex] received everything.

2019-11-25 20:02:31 | [Mutex] isItemNotified: authFailed :: true

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

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2xiNzlwbTAwMzAscj10NXhYc2pWTjlNc0NDakllSjMyOA==</auth>

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10NXhYc2pWTjlNc0NDakllSjMyOElCNTBCd2tQUWZSaDZOcldLM3BxLHM9TVlvWmpONnRyMFI3RHc9PSxpPTQwOTY=</challenge>

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dDV4WHNqVk45TXNDQ2pJZUozMjhJQjUwQndrUFFmUmg2TnJXSzNwcSxwPU5DUUxtQ3Z2ckxuRzBRZTNJME03eThCYVFqelpKS2UyOGV3bTRTWEdhOGM9</response>

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1teGhxaTA3QXNFSVBnNUFjdndPRHFsMVF4MytmS216RHlHMUl0OXN4aUlVPQ==</success>

2019-11-25 20:02:32 | user :: user_lb79pm0030@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" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU="/></features>

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost >> <iq xmlns="jabber:client" id="6bQJNMHOGw5kS1t0fZbJP3u" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost << <iq to="user_lb79pm0030@localhost/993927746-tigase-23" type="result" xmlns="jabber:client" id="6bQJNMHOGw5kS1t0fZbJP3u"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_lb79pm0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="7YbFwbMCoPOQXlKJX7BzxsZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost/993927746-tigase-23 << <iq to="user_lb79pm0030@localhost/993927746-tigase-23" type="result" xmlns="jabber:client" id="7YbFwbMCoPOQXlKJX7BzxsZ"/>

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

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

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost/993927746-tigase-23 << <enabled max="60" resume="true" location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="1e513983-8352-4ac1-b7af-8a7e339d4f7c"/>

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost/993927746-tigase-23 >> <iq id="X0dQ3v0eFEoPT5fPQP4cy9s" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost/993927746-tigase-23 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-25 20:02:32 | user :: user_lb79pm0030@localhost/993927746-tigase-23 << <iq to="user_lb79pm0030@localhost/993927746-tigase-23" from="localhost" type="result" xmlns="jabber:client" id="x7As03lZ3r4hY0anU2l7iP9"><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 var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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 20:02:32 | user :: user_lb79pm0030@localhost/993927746-tigase-23 << <iq to="user_lb79pm0030@localhost/993927746-tigase-23" type="result" xmlns="jabber:client" id="X0dQ3v0eFEoPT5fPQP4cy9s"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 20:02:32 | Disconnecting

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

2019-11-25 20:02:32 | [Mutex] notify: [disconnected]

2019-11-25 20:02:32 | [Mutex] received everything.

2019-11-25 20:02:34 | [Mutex] waiting for: [user]

2019-11-25 20:02:34 | [Mutex] received everything.

2019-11-25 20:02:34 | [Mutex] isItemNotified: user:ok:true :: true