Brute Force Prevention

2019-11-26 18:27:04 |

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

2019-11-26 18:27:04 | ------------------------------------

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@746da323

2019-11-26 18:27:04 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7aaa43de}, 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@7e95c853}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b9749e5}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@227a810f}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:04 PST 2019}}}}

2019-11-26 18:27:04 | [Mutex] waiting for: [registration]

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@ae6922d

2019-11-26 18:27:04 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7aaa43de}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@7e95c853}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b9749e5}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@227a810f}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:04 PST 2019}}}}

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@5ae10472

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

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

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

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2dbc262b

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1375be4b

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

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

2019-11-26 18:27:04 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1f2d95a0}

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

2019-11-26 18:27:04 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5ff609b3}

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1337f118

2019-11-26 18:27:04 | user :: null >> <iq to="localhost" id="kGhWhXiS8jW7xbRO1fWfV3u" type="set"><query xmlns="jabber:iq:register"><username>user_q9obwf0027</username><password>user_q9obwf0027</password><email>d4279a9e-3a0c-4ce9-b2f4-e8e975f7ffc1@localhost</email></query></iq>

2019-11-26 18:27:04 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3b78695d}

2019-11-26 18:27:04 | user :: null << <iq xmlns="jabber:client" from="localhost" type="result" id="kGhWhXiS8jW7xbRO1fWfV3u"/>

2019-11-26 18:27:04 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2d0e92d3}

2019-11-26 18:27:04 | [Mutex] received everything.

2019-11-26 18:27:04 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 18:27:04 | 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;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5bb8b6aa, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@41e5eac3]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7aaa43de}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@7e95c853}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b9749e5}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@227a810f}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:04 PST 2019}}}}

2019-11-26 18:27:04 | 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;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5bb8b6aa, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@41e5eac3]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7aaa43de}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@7e95c853}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3b9749e5}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@227a810f}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:04 PST 2019}}}}

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@43d3c643

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2c87f41b

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@947fa2

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@59d5fd69

2019-11-26 18:27:04 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@469c9ce

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

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

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SUndnYVBqTWhSbExjcVlMbEo5R0JrUnlSWTRsQlRjRmozNEZDMjM2LHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UlJ3Z2FQak1oUmxMY3FZTGxKOUdCa1J5Ulk0bEJUY0ZqMzRGQzIzNixwPVUxRHlQVGNGOTJzUEc0SnJNTDAyRXdmVU9JbThDdmZLRS9PUUZ3WGNha1k9</response>

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1DT04zLzlOZTk2TkZsUnRmeFhoR3RGdWR2aitod2t3eGV6ajBNbVBDSExRPQ==</success>

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

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost >> <iq xmlns="jabber:client" id="TPGIIOFExnRdwr5CBDtkXla" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="RRKR7CwqT6rbtrYlTeP5n8z" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" to="user_q9obwf0027@localhost/993927746-tigase-19" type="result" id="RRKR7CwqT6rbtrYlTeP5n8z"/>

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

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

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost/993927746-tigase-19 << <enabled id="1bc5b306-2b70-4b33-94ea-5569b48c64b0" max="60" location="d4270859fb27" resume="true" xmlns="urn:xmpp:sm:3"/>

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost/993927746-tigase-19 >> <iq id="cXYoSKAgRYdQ5zwk27ylZ5F" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost/993927746-tigase-19 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" from="localhost" to="user_q9obwf0027@localhost/993927746-tigase-19" type="result" id="BPCDtkXlaO6iAgCzo3wrhWa"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="server" type="im"/><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 category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-26 18:27:04 | user :: user_q9obwf0027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" to="user_q9obwf0027@localhost/993927746-tigase-19" type="result" id="cXYoSKAgRYdQ5zwk27ylZ5F"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:27:04 | Disconnecting

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

2019-11-26 18:27:04 | [Mutex] notify: [disconnected]

2019-11-26 18:27:04 | [Mutex] received everything.

2019-11-26 18:27:04 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XSXhkWDl4cmphenp6MG1QM2hXZUk2YnhMS3V5aVV1aDFJa2pldVFSLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V0l4ZFg5eHJqYXp6ejBtUDNoV2VJNmJ4TEt1eWlVdWgxSWtqZXVRUixwPWZ0dC9SUCtMd1hDcVhUN3N3OERZV0FmdFM0cEJLeFdOaU5kS0VpUG5Zbkk9</response>

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

2019-11-26 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:05 | [Mutex] notify: [event, disconnected]

2019-11-26 18:27:05 | [Mutex] received everything.

2019-11-26 18:27:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:05 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YTHZvZUFDT1J0QnFYVjJmWTUzODBrcFVnckc4NU9pc1NVWkx0TnlaLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WEx2b2VBQ09SdEJxWFYyZlk1Mzgwa3BVZ3JHODVPaXNTVVpMdE55WixwPWR4RFVidm4rUkI0QkFCaGNsTzhJenF5YW5aMGthWWFicFJVbVV0Nk1RUTQ9</response>

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

2019-11-26 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:05 | [Mutex] notify: [event, disconnected]

2019-11-26 18:27:05 | [Mutex] received everything.

2019-11-26 18:27:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:05 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jU3AwNlBmWnNxRWQzb1dRV29ORkZYT0xjOHN4Wlk2bXdNMkFEVTFoLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y1NwMDZQZlpzcUVkM29XUVdvTkZGWE9MYzhzeFpZNm13TTJBRFUxaCxwPWF0a3hYaGNMQmVUb1ZqQW5zeERXYWZWemVoenM0Z1g3enk4Nlo1QTFFR3M9</response>

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

2019-11-26 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:05 | [Mutex] received everything.

2019-11-26 18:27:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:05 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EV2tZaWRtWThaaVBQSmJVaWR4UkxKODlsWEZLNDhGMW9WWUpZQUp5LHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RFdrWWlkbVk4WmlQUEpiVWlkeFJMSjg5bFhGSzQ4RjFvVllKWUFKeSxwPW5KaGZOSjVzSklXdWpKVnpMbUdpRDZPc29pQjVpRWxBcjVKNEdINFFnUTg9</response>

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

2019-11-26 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:05 | [Mutex] received everything.

2019-11-26 18:27:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:05 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LZ25OcjQ5Y0xrM004VTBZMWdZcGdrblRITXB2TEQyb2F2RFloNHhwLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S2duTnI0OWNMazNNOFUwWTFnWXBna25USE1wdkxEMm9hdkRZaDR4cCxwPURlZVlnZ1Zwc01ZdVdFV1A4b05mTlhDMXZZaGh4bVNhQmZvMFByTTRVUTA9</response>

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

2019-11-26 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:05 | [Mutex] received everything.

2019-11-26 18:27:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:05 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BUUFJeDFSSkdWVG14NWhwdXJHUUs2VkdTN3YzRkpaNzRrdm1Mc1ZNLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QVFBSXgxUkpHVlRteDVocHVyR1FLNlZHUzd2M0ZKWjc0a3ZtTHNWTSxwPW9JeG1MOTlkM3pxRmtsaU03M0JQYTlwUUs3aUp6WEJURjBXNEZIZlVldXc9</response>

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

2019-11-26 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:05 | [Mutex] received everything.

2019-11-26 18:27:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:05 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pMHd6UWNRdUI3bkJ4MXJFSTJsOENYTnI4Vm0yV2ROZWY5clJLdWROLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:05 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aTB3elFjUXVCN25CeDFyRUkybDhDWE5yOFZtMldkTmVmOXJSS3VkTixwPVRoSjdpcjd6ZHkrWi9lRWcrRmcvWGlwRy95amc1TTJ4ZURoeW82WmZYdlU9</response>

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

2019-11-26 18:27:05 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:05 | [Mutex] received everything.

2019-11-26 18:27:05 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:05 | [Mutex] notify: [event, disconnected]

2019-11-26 18:27:06 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YaHNuUzRUSXdGNGxpTnFUbjZ6aHNOU01MV1BPZWdRcG0zUHhIZHVMLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WGhzblM0VEl3RjRsaU5xVG42emhzTlNNTFdQT2VnUXBtM1B4SGR1TCxwPU9yckxWWlVLNldIelVKVU1WcTRKTkFkS0lxaFpWWlVsRllzdXBRTU9PZE09</response>

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

2019-11-26 18:27:06 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:06 | [Mutex] received everything.

2019-11-26 18:27:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:06 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0za0M4R0xsaXo4TWJneUVnZjFTSXlMamJHcHNLRm5xSHBZeE5NeklvLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M2tDOEdMbGl6OE1iZ3lFZ2YxU0l5TGpiR3BzS0ZucUhwWXhOTXpJbyxwPUN6VVBiN3dFOWtNUkRmNHBKUUJJRkRHQWsrQkdoRlpyY0ZXdlpUaTNvcjg9</response>

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

2019-11-26 18:27:06 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:06 | [Mutex] received everything.

2019-11-26 18:27:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:06 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Xd0xMZlBGSGoxNTJmUFNMTnNBcEpacGo1Mno2dHR3Nk1DSlZGbmVnLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V3dMTGZQRkhqMTUyZlBTTE5zQXBKWnBqNTJ6NnR0dzZNQ0pWRm5lZyxwPXRXdUxGaEliQzhtdnBDT1NQQ1RlTGo1TEVPZzhxbDVXb1kwSHcyNnh0WGc9</response>

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

2019-11-26 18:27:06 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:06 | [Mutex] received everything.

2019-11-26 18:27:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:06 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04ZlJCU2Z4ZUl3WEREN0NHTkdWWGFYNU5yZ2U5UHpSdnNZdWhZWVJPLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OGZSQlNmeGVJd1hERDdDR05HVlhhWDVOcmdlOVB6UnZzWXVoWVlSTyxwPUp4SjIvQUxOYW1Xd2lmaXhiQ0k3cVpkUnd5NTVUaHN6WXNFcnMvQVMvSkk9</response>

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

2019-11-26 18:27:06 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:06 | [Mutex] received everything.

2019-11-26 18:27:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:06 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TM2xTS1NwbFZLeW5Fb3RGdFZiQ3ZEa0NVOW10bkZwVXBrdmhzVDlVLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UzNsU0tTcGxWS3luRW90RnRWYkN2RGtDVTltdG5GcFVwa3Zoc1Q5VSxwPVVBdDZKY2xKMWJva3E1QXI2N2c0TTJiVkZCanpTTkFKT3pQRnRkSmd5SFk9</response>

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

2019-11-26 18:27:06 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:06 | [Mutex] received everything.

2019-11-26 18:27:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:06 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MWUtxYzRSVjNjd3ZiOTVFZmlKMW44RjJMYUJKYkNJeWhXSjR4N3BKLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:06 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TFlLcWM0UlYzY3d2Yjk1RWZpSjFuOEYyTGFCSmJDSXloV0o0eDdwSixwPTdRRWtFbDFocDI1UjlBenNiaHVXVTQwRi9MVzI2NVhGT1dYbmtrNW5aTkk9</response>

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

2019-11-26 18:27:06 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:06 | [Mutex] received everything.

2019-11-26 18:27:06 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:06 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TSWlFNTkzWXNkeEtrMUYybTRXd0R6Y0dQRlZFUUJ5T1J4ck5seFR2LHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U0lpRTU5M1lzZHhLazFGMm00V3dEemNHUEZWRVFCeU9SeHJObHhUdixwPWVoRkYvSVUwZGdCamJJZURlQkd2dEF6MGpNT3FXb1NPcWhYdGZwUU1TYTQ9</response>

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

2019-11-26 18:27:07 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:07 | [Mutex] received everything.

2019-11-26 18:27:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:07 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iZWg3NkNzb0V2WHBmZFR6dXZFdERkdnlvcUk4eHNMRmlpOUQwR0pGLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YmVoNzZDc29FdlhwZmRUenV2RXREZHZ5b3FJOHhzTEZpaTlEMEdKRixwPU9CQy9rbjRLZjk3dGZ2Tlc2b3ovVEtvZ2k5RGw1eWJDaWpWekwxV1ZnbFU9</response>

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

2019-11-26 18:27:07 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:07 | [Mutex] received everything.

2019-11-26 18:27:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:07 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04cFRneWU0cENyQlVTZkpSMWFkTWE4eGtLa0lISWNwS0VKRW9rWWRZLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OHBUZ3llNHBDckJVU2ZKUjFhZE1hOHhrS2tJSEljcEtFSkVva1lkWSxwPW5tQkJoblNBNDI1ZVgrc09RS214OW9TZGRFTmF6dEhkWmVoSk1MRVhza0E9</response>

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

2019-11-26 18:27:07 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:07 | [Mutex] received everything.

2019-11-26 18:27:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:07 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SY215M0VSOTFoOWdvRFdha0xIeThCaFVaUzRoQkxWbGs5Q3FuMjJKLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UmNteTNFUjkxaDlnb0RXYWtMSHk4QmhVWlM0aEJMVmxrOUNxbjIySixwPTJiNlVoMWV1S1RLRWowN3pUSWVXdHpFUDREWmVzeFdxbk1nOTJGTW5GaWs9</response>

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

2019-11-26 18:27:07 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:07 | [Mutex] received everything.

2019-11-26 18:27:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:07 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13Q0xzQll3WkY5TE1GZVpXUXdyT0dCYWoyd3NTMGxnOGNZR2s2bU5mLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d0NMc0JZd1pGOUxNRmVaV1F3ck9HQmFqMndzUzBsZzhjWUdrNm1OZixwPUdWUE91b3huaUdZcVBQaG1XVlZid0s0OHJlM1E3alIwUEcyazh6c3RaU1k9</response>

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

2019-11-26 18:27:07 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:07 | [Mutex] received everything.

2019-11-26 18:27:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:07 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16eHdVaFdiZjBWYW43aUR5NnFpSDlMMlFqNGdGNE5KVVBXYmZucnFkLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9enh3VWhXYmYwVmFuN2lEeTZxaUg5TDJRajRnRjROSlVQV2JmbnJxZCxwPVhMMlZSZGhJUGdmTG1MaFMwV0ZjME02RXJ2K0ExK1Vjd2xqYjZISFVJK0U9</response>

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

2019-11-26 18:27:07 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:07 | [Mutex] received everything.

2019-11-26 18:27:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:07 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NUlpSQmlhbEtld1RpSmFLQWFBa2p6a210NVh5MGxPOW1PeUJRSG5qLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:07 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TVJaUkJpYWxLZXdUaUphS0FhQWtqemttdDVYeTBsTzltT3lCUUhuaixwPTVrU1c3L2xsTkVWaE9PK3d0RUJQdE5leXl1WmFsQVJpeUtxdGJXdW9peEE9</response>

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

2019-11-26 18:27:07 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:07 | [Mutex] received everything.

2019-11-26 18:27:07 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:07 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:08 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UVE5WUVpvQkxtaDhIUlpEODJiN2dIVWNTd2tMcTZZMkV3WUZhVURGLHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:08 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VFROVlFab0JMbWg4SFJaRDgyYjdnSFVjU3drTHE2WTJFd1lGYVVERixwPXZjbzB1aTRUVTRiSGN1NHBjcnNJWGZvR0JmVkN6cFJBSnVLbU9lOTZkZEE9</response>

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

2019-11-26 18:27:08 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:08 | [Mutex] notify: [event, disconnected]

2019-11-26 18:27:08 | [Mutex] received everything.

2019-11-26 18:27:08 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-26 18:27:08 | user :: user_q9obwf0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15VkE5a1Y2SUNiSm5yV0FHeE5GbE1MU2lzWVNGMVdDS2NKMTlSR3A5LHM9U1NjNVV0dEc5ckhpNVE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:08 | user :: user_q9obwf0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eVZBOWtWNklDYkpucldBR3hORmxNTFNpc1lTRjFXQ0tjSjE5UkdwOSxwPXZwdFNsRUFSUGhPYTZXU0R4NFZPd0hXS1JXL2pFOEoxR3NlV2tyb2p4cEU9</response>

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

2019-11-26 18:27:10 | [Mutex] waiting for: [user]

2019-11-26 18:27:10 | [Mutex] received everything.

2019-11-26 18:27:10 | [Mutex] isItemNotified: user:ok:false :: true

2019-11-26 18:27:10 |

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

2019-11-26 18:27:10 | ------------------------------------

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@299c66d5

2019-11-26 18:27:10 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@275b8d96}, 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@23640da5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@666687ad}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2c86ef7a}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:10 PST 2019}}}}

2019-11-26 18:27:10 | [Mutex] waiting for: [registration]

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@574ae041

2019-11-26 18:27:10 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@275b8d96}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@23640da5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@666687ad}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2c86ef7a}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:10 PST 2019}}}}

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@5440d628

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

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

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

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1dafaa6e

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1d671972

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

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

2019-11-26 18:27:10 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@88744399}

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@2078202

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

2019-11-26 18:27:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@621ba4f6}

2019-11-26 18:27:10 | user :: null >> <iq to="localhost" id="H12ww8gCkZeJS9HMQ4bGBv7" type="set"><query xmlns="jabber:iq:register"><username>user_e26f820028</username><password>user_e26f820028</password><email>9dd60893-cc22-4e64-a2d6-cc541a41b400@localhost</email></query></iq>

2019-11-26 18:27:10 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@788285ae}

2019-11-26 18:27:10 | [Mutex] received everything.

2019-11-26 18:27:10 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 18:27:10 | user :: null << <iq xmlns="jabber:client" from="localhost" type="result" id="H12ww8gCkZeJS9HMQ4bGBv7"/>

2019-11-26 18:27:10 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@47929d4e}

2019-11-26 18:27:10 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@64978e2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4f447d60]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@275b8d96}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@23640da5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@666687ad}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2c86ef7a}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:10 PST 2019}}}}

2019-11-26 18:27:10 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@64978e2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4f447d60]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@275b8d96}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@23640da5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@666687ad}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2c86ef7a}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:10 PST 2019}}}}

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2bd157a1

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@15f8d74b

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2afbfd16

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

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@79d06dea

2019-11-26 18:27:10 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@581d512e

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

2019-11-26 18:27:10 | user :: user_e26f820028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00TlZJa1JFU0dMNjJVdGFmM21TdXQ3ekFiSGFxQThzUFR6NUVKS2djLHM9bytweUE0bndLVDJLVEE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NE5WSWtSRVNHTDYyVXRhZjNtU3V0N3pBYkhhcUE4c1BUejVFSktnYyxwPVU2blZTV2V6K2xHUHZiMUtUN0ppYnUxclF1YmpzQm0vSnh3eWt1SVNFY1U9</response>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj14SWRHNDdoRis2TEY5TFFFc01tVlY3MzIrNTBudEt2aGtWT2wycjBrbjc4PQ==</success>

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

2019-11-26 18:27:10 | user :: user_e26f820028@localhost >> <iq xmlns="jabber:client" id="8WLN1www8gCkZeJS9HMQ4bG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost << <iq xmlns="jabber:client" to="user_e26f820028@localhost/993927746-tigase-20" type="result" id="8WLN1www8gCkZeJS9HMQ4bG"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_e26f820028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="mYP1q8El0fNHTS9vshZbKN1" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" to="user_e26f820028@localhost/993927746-tigase-20" type="result" id="mYP1q8El0fNHTS9vshZbKN1"/>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost/993927746-tigase-20 >> <iq to="localhost" id="7NgS3xyAEoMEo7ufUdP2m6f" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2019-11-26 18:27:10 | user :: user_e26f820028@localhost/993927746-tigase-20 << <enabled id="5f33dc3e-0999-492d-8fc4-38ea73c8e705" max="60" location="d4270859fb27" resume="true" xmlns="urn:xmpp:sm:3"/>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost/993927746-tigase-20 >> <iq id="H56EMEiGsfKLWhXiS8jW7xb" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" from="localhost" to="user_e26f820028@localhost/993927746-tigase-20" type="result" id="7NgS3xyAEoMEo7ufUdP2m6f"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="server" type="im"/><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 category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost/993927746-tigase-20 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" to="user_e26f820028@localhost/993927746-tigase-20" type="result" id="H56EMEiGsfKLWhXiS8jW7xb"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:27:10 | Disconnecting

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

2019-11-26 18:27:10 | [Mutex] notify: [disconnected]

2019-11-26 18:27:10 | [Mutex] received everything.

2019-11-26 18:27:10 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:10 | user :: user_e26f820028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yNURocU12MWpGbG5Oa1pqMDVWWUJOaVE0ajBRRUZRUXZ4YXlia1ZkLHM9bytweUE0bndLVDJLVEE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:10 | user :: user_e26f820028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MjVEaHFNdjFqRmxuTmtaajA1VllCTmlRNGowUUVGUVF2eGF5YmtWZCxwPVJvNEJWVktxemNjNkorRE1SNkhhdTh5cmJsWHpzRGMwM1FNcGFNZFB3akU9</response>

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

2019-11-26 18:27:10 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:10 | [Mutex] received everything.

2019-11-26 18:27:10 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:10 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:11 | user :: user_e26f820028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NTndZWDJOamlZcFBPUHZuR01UbjZKOWpEdHd3dnBwaE5vZjhQN3JxLHM9bytweUE0bndLVDJLVEE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:11 | user :: user_e26f820028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TU53WVgyTmppWXBQT1B2bkdNVG42SjlqRHR3d3ZwcGhOb2Y4UDdycSxwPWEzUTRpS0pKYkh5MVlUczdoR3U0cC96Z2xUcW02K2ZHc21QdTUxc2pGckE9</response>

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

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

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

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

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

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

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

2019-11-26 18:27:11 | user :: user_e26f820028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ibnF5YUVtTFk3ZW1tYWpWUDVnVGJZeThDSXpoS2pEVG5nZDJiWmNELHM9bytweUE0bndLVDJLVEE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:11 | user :: user_e26f820028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Ym5xeWFFbUxZN2VtbWFqVlA1Z1RiWXk4Q0l6aEtqRFRuZ2QyYlpjRCxwPVgrajVqVGtaZmFYNG5jWEduYnZRaEUvbjZGSDhDSCtubnNlaUNQY1hzQUk9</response>

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

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

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

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

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

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

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

2019-11-26 18:27:11 | user :: user_e26f820028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DSnE4d1VsaHVJNDA5aHlCcWpHTVNyTHFta0ZBVmNPSEpQUDZKWHdpLHM9bytweUE0bndLVDJLVEE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:11 | user :: user_e26f820028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q0pxOHdVbGh1STQwOWh5QnFqR01TckxxbWtGQVZjT0hKUFA2Slh3aSxwPUQyS2dyNWV6U29DSkQxWjFPdklPc1E2RXBPNnpIdTAvUitzRENFUzQxNVk9</response>

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

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

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

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

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

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

2019-11-26 18:27:11 | user :: user_e26f820028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10eFZxeDBiUndBVjd0cldOdlhYdjE3WXByN0ZTUXAwd0ZjZ0JvcUpxLHM9bytweUE0bndLVDJLVEE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:11 | user :: user_e26f820028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dHhWcXgwYlJ3QVY3dHJXTnZYWHYxN1lwcjdGU1FwMHdGY2dCb3FKcSxwPXBnOW53aTM5SFNDKzBOcm8rV24zc2Z3Wm4vZmtCSlJHMXp4NjJpaEEyN289</response>

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

2019-11-26 18:27:13 | [Mutex] waiting for: [user]

2019-11-26 18:27:13 | [Mutex] received everything.

2019-11-26 18:27:13 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-26 18:27:13 |

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

2019-11-26 18:27:13 | ------------------------------------

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3e0c62b5

2019-11-26 18:27:13 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@30cb9b04}, 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@34f409c5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@71f6913f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2cb25c7e}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:13 PST 2019}}}}

2019-11-26 18:27:13 | [Mutex] waiting for: [registration]

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@404de157

2019-11-26 18:27:13 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@30cb9b04}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@34f409c5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@71f6913f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2cb25c7e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:13 PST 2019}}}}

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@54e372ba

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

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

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

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2fb69199

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@de8a61

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

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

2019-11-26 18:27:13 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8881a60c}

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

2019-11-26 18:27:13 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@15971300}

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@e366272

2019-11-26 18:27:13 | user :: null >> <iq to="localhost" id="G61usoSKAgRYdQ5zwk27ylZ" type="set"><query xmlns="jabber:iq:register"><username>user_gncy9p0029</username><password>user_gncy9p0029</password><email>9d03e2f6-1992-4b03-915a-6e1968d91395@localhost</email></query></iq>

2019-11-26 18:27:13 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7945901}

2019-11-26 18:27:13 | [Mutex] received everything.

2019-11-26 18:27:13 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 18:27:13 | user :: null << <iq xmlns="jabber:client" from="localhost" type="result" id="G61usoSKAgRYdQ5zwk27ylZ"/>

2019-11-26 18:27:13 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7a4f6c57}

2019-11-26 18:27:13 | 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;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@11d96e70, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4fe75e62]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@30cb9b04}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@34f409c5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@71f6913f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2cb25c7e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:13 PST 2019}}}}

2019-11-26 18:27:13 | 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;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@11d96e70, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4fe75e62]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@30cb9b04}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@34f409c5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@71f6913f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2cb25c7e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:13 PST 2019}}}}

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@f2e2932

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@220c24c4

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1f94e705

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1e381d74

2019-11-26 18:27:13 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@60a1d038

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

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

2019-11-26 18:27:13 | user :: user_gncy9p0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XUmNweFNGbjFHRVdlQzRNTGFpMWNSZWFYamtOZDE2U2hKT1VJQUtoLHM9R0FrazE4ZkxGc2E5SHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:13 | user :: user_gncy9p0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V1JjcHhTRm4xR0VXZUM0TUxhaTFjUmVhWGprTmQxNlNoSk9VSUFLaCxwPWIvNXpmWnNRNFFHTmpWeCtkbURnZjJJdmFRdVlqTGtXK0IzbGxQaTA1alk9</response>

2019-11-26 18:27:13 | user :: user_gncy9p0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj03czhpSmRCRjJucHVuZUdjK1BDSHFMR3R0ay9ESjdiZnlmSU9SRmhJUUNNPQ==</success>

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

2019-11-26 18:27:13 | user :: user_gncy9p0029@localhost >> <iq xmlns="jabber:client" id="IabOIqWYhOTcNZm0oPYbFrn" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

2019-11-26 18:27:13 | user :: user_gncy9p0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="IbcQMycujS1sj1q8El0fNHT" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-26 18:27:13 | user :: user_gncy9p0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" to="user_gncy9p0029@localhost/993927746-tigase-21" type="result" id="IbcQMycujS1sj1q8El0fNHT"/>

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

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

2019-11-26 18:27:13 | user :: user_gncy9p0029@localhost/993927746-tigase-21 << <enabled id="78c978c5-3edc-4e40-bb8f-36857282c26c" max="60" location="d4270859fb27" resume="true" xmlns="urn:xmpp:sm:3"/>

2019-11-26 18:27:13 | user :: user_gncy9p0029@localhost/993927746-tigase-21 >> <iq id="ZYvhFPKTZqdRVeLXog06cu4" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:27:13 | user :: user_gncy9p0029@localhost/993927746-tigase-21 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-26 18:27:13 | user :: user_gncy9p0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" from="localhost" to="user_gncy9p0029@localhost/993927746-tigase-21" type="result" id="m7Yj0iYZiPX1xaJFMVhLU7F"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="server" type="im"/><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 category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-26 18:27:14 | user :: user_gncy9p0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" to="user_gncy9p0029@localhost/993927746-tigase-21" type="result" id="ZYvhFPKTZqdRVeLXog06cu4"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:27:14 | Disconnecting

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

2019-11-26 18:27:14 | [Mutex] notify: [disconnected]

2019-11-26 18:27:14 | [Mutex] received everything.

2019-11-26 18:27:14 | [Mutex] waiting for: [event]

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

2019-11-26 18:27:14 | user :: user_gncy9p0029@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-26 18:27:14 | user :: user_gncy9p0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2duY3k5cDAwMjkscj1HZ1VvQ2VPSWhDZ2Nza2VrZkdYdw==</auth>

2019-11-26 18:27:14 | user :: user_gncy9p0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HZ1VvQ2VPSWhDZ2Nza2VrZkdYd3hDSlJYVFpwaG1adEVNOEtiMG1PLHM9eldjZ0JpSHZpeVlieXc9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:14 | user :: user_gncy9p0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R2dVb0NlT0loQ2djc2tla2ZHWHd4Q0pSWFRacGhtWnRFTThLYjBtTyxwPUFIeXpzMU83dXBtTDNNM01ibitBRExpcDFsWT0=</response>

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

2019-11-26 18:27:14 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:14 | [Mutex] notify: [event, disconnected]

2019-11-26 18:27:14 | [Mutex] received everything.

2019-11-26 18:27:14 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:14 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:14 | user :: user_gncy9p0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16bGNWWnltMzF2UEo4ejdKUVFRcWlJWm5ob1labEpERWxGcDN2ZnRqLHM9R0FrazE4ZkxGc2E5SHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:14 | user :: user_gncy9p0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9emxjVlp5bTMxdlBKOHo3SlFRUXFpSVpuaG9ZWmxKREVsRnAzdmZ0aixwPVRkL1dlQVcyeEtnNVhPeTF5NGhJZXliRUp4Sjg3M0ViSkZRTWdqU1hQYTQ9</response>

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

2019-11-26 18:27:14 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:14 | [Mutex] received everything.

2019-11-26 18:27:14 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:14 | [Mutex] waiting for: [event]

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

2019-11-26 18:27:14 | user :: user_gncy9p0029@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-26 18:27:14 | user :: user_gncy9p0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2duY3k5cDAwMjkscj1saHFQYU5hbWw2V3BFWUhtcjBSMA==</auth>

2019-11-26 18:27:14 | user :: user_gncy9p0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1saHFQYU5hbWw2V3BFWUhtcjBSMHlKZmJPcW1DRmR0QzZrdWF5SjRmLHM9eldjZ0JpSHZpeVlieXc9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:14 | user :: user_gncy9p0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bGhxUGFOYW1sNldwRVlIbXIwUjB5SmZiT3FtQ0ZkdEM2a3VheUo0ZixwPTNuaSsyZ0VsT2creDFoeE9ZTnlBeFJudEtaUT0=</response>

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

2019-11-26 18:27:14 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:14 | [Mutex] received everything.

2019-11-26 18:27:14 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:14 | [Mutex] waiting for: [event]

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

2019-11-26 18:27:14 | user :: user_gncy9p0029@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-26 18:27:14 | user :: user_gncy9p0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfZ25jeTlwMDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-26 18:27:14 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:14 | [Mutex] received everything.

2019-11-26 18:27:14 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-26 18:27:14 | user :: user_gncy9p0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UR24yYkJZOGlQSUJtTDc2VnlsU0xWOXpaVGQ2UHJzUnlqWHhpenVjLHM9R0FrazE4ZkxGc2E5SHc9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:14 | user :: user_gncy9p0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VEduMmJCWThpUElCbUw3NlZ5bFNMVjl6WlRkNlByc1J5alh4aXp1YyxwPWdRSzNjZHc0NzRZUTBPQnZyVHZtZmZWellEWGdIRDJqMW1rUGlaVlQrcVE9</response>

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

2019-11-26 18:27:16 | [Mutex] waiting for: [user]

2019-11-26 18:27:16 | [Mutex] received everything.

2019-11-26 18:27:16 | [Mutex] isItemNotified: user:ok:true :: true

2019-11-26 18:27:16 |

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

2019-11-26 18:27:16 | ------------------------------------

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1636e591

2019-11-26 18:27:16 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18f10927}, 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@1cce8ee1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59cc031c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@78f77fd9}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:16 PST 2019}}}}

2019-11-26 18:27:16 | [Mutex] waiting for: [registration]

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@68dff9d1

2019-11-26 18:27:16 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18f10927}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@1cce8ee1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59cc031c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@78f77fd9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:16 PST 2019}}}}

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@edbad

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

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

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

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7a295501

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@6d2f3ae4

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

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

2019-11-26 18:27:16 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3978ed26}

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

2019-11-26 18:27:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3dad2109}

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@d1cfae0

2019-11-26 18:27:16 | user :: null >> <iq to="localhost" id="D0tiTdUi4es06xkVgVfS2sX" type="set"><query xmlns="jabber:iq:register"><username>user_qw3y6c0030</username><password>user_qw3y6c0030</password><email>06aef259-c31b-4cdb-8f2c-2564b5b7b895@localhost</email></query></iq>

2019-11-26 18:27:16 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@93b783d9}

2019-11-26 18:27:16 | user :: null << <iq xmlns="jabber:client" from="localhost" type="result" id="D0tiTdUi4es06xkVgVfS2sX"/>

2019-11-26 18:27:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@19f019bd}

2019-11-26 18:27:16 | [Mutex] received everything.

2019-11-26 18:27:16 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-26 18:27:16 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39e3fc53, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1b0a575f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18f10927}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@1cce8ee1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59cc031c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@78f77fd9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:16 PST 2019}}}}

2019-11-26 18:27:16 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@266ffa07}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39e3fc53, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1b0a575f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18f10927}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6752f03c}, 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@1cce8ee1}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59cc031c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@78f77fd9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Tue Nov 26 18:27:16 PST 2019}}}}

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@50890573

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@478d302

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6e59f297

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@77fd3310

2019-11-26 18:27:16 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6fc71201

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

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12T3FWODdrMm83V0JVbW1KSmJaZEQxcmxDZ0Y2VHdETmlCVVNNMmdKLHM9eEQwRjdaT1lRQ3E3cUE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dk9xVjg3azJvN1dCVW1tSkpiWmREMXJsQ2dGNlR3RE5pQlVTTTJnSixwPWVKQU90ZUtRaWp5eTFlM3JuTlViZWl1UW1DMUhzUGVjZWpkbDd0bFo2Rzg9</response>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1JY1I5Y3hMdTRqQzhDaWVPaWx4amc2NVl4ODFHaUVzbE9qRHg0TDRxcG5VPQ==</success>

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost >> <iq xmlns="jabber:client" id="eU9gCkZeJS9HMQ4bGBv7Jyv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" to="user_qw3y6c0030@localhost/993927746-tigase-22" type="result" id="eVaiGsfKLWhXiS8jW7xbRO1"/>

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

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-22 << <enabled id="1d576c74-a3c2-4568-96df-00164c301f3f" max="60" location="d4270859fb27" resume="true" xmlns="urn:xmpp:sm:3"/>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-22 >> <iq id="Q8JQ5zwk27ylZ5FqfHQ3xhW" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" from="localhost" to="user_qw3y6c0030@localhost/993927746-tigase-22" type="result" id="YaRV9pjIPRaHPR6vrmcSQGs"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="server" type="im"/><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 category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-22 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" to="user_qw3y6c0030@localhost/993927746-tigase-22" type="result" id="Q8JQ5zwk27ylZ5FqfHQ3xhW"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:27:17 | Disconnecting

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

2019-11-26 18:27:17 | [Mutex] notify: [disconnected]

2019-11-26 18:27:17 | [Mutex] received everything.

2019-11-26 18:27:17 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zM29ZQ0F3Rlh0TUZVT3B1eTg1UUtUYUhFcEF6MGRjNGF2MjFWSEpDLHM9eEQwRjdaT1lRQ3E3cUE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9czNvWUNBd0ZYdE1GVU9wdXk4NVFLVGFIRXBBejBkYzRhdjIxVkhKQyxwPVFCT1BqbGtVQkc1S1IxMDJsZlRHSzlwaVRXOU43WTRXd2tmbzRmVi9ENE09</response>

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

2019-11-26 18:27:17 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:17 | [Mutex] received everything.

2019-11-26 18:27:17 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:17 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zZ0pqZlJhNkJXZ3d5VlU5dENTbnUydjdFcWZWMUFIZnprdFVLNkpwLHM9eEQwRjdaT1lRQ3E3cUE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c2dKamZSYTZCV2d3eVZVOXRDU251MnY3RXFmVjFBSGZ6a3RVSzZKcCxwPTJzekxiOXNrMW9VajhpVXRJcHNWUnJOa1FNelNodTFQZit6RkxEaUlwUkE9</response>

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

2019-11-26 18:27:17 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:17 | [Mutex] received everything.

2019-11-26 18:27:17 | [Mutex] isItemNotified: authFailed :: true

2019-11-26 18:27:17 | [Mutex] waiting for: [event]

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

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QVjJpUHo2Rk15cFhKbzdRMkVUNTQybG9oaVozZEtBcEdwc24wWU11LHM9eEQwRjdaT1lRQ3E3cUE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UFYyaVB6NkZNeXBYSm83UTJFVDU0MmxvaGlaM2RLQXBHcHNuMFlNdSxwPWlNRlNyMW0xOFNTRzFRNjlXNUNkaFJndVdFN3diWk1WQVB2TU4xSFB5Vm89</response>

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

2019-11-26 18:27:17 | [Mutex] notify: [event, authFailed]

2019-11-26 18:27:17 | [Mutex] received everything.

2019-11-26 18:27:17 | [Mutex] isItemNotified: authFailed :: true

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

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RUTlOMGlUSE1mZUZUZkJLMTgydTFQc2l6YXdnM1N2VVlGUUszZk1XLHM9eEQwRjdaT1lRQ3E3cUE9PSxpPTQwOTY=</challenge>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UVE5TjBpVEhNZmVGVGZCSzE4MnUxUHNpemF3ZzNTdlVZRlFLM2ZNVyxwPXp0V0VMdHRONTR3c1FOMndrMzJQMWJVa3d1V2hYdS9BbGROY0QyeWExWGs9</response>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj14N0l0N2lTd1ppSVdzNjZLVGRwVVpoTGsraVIwdVlZYWx1WkNkOEdwcTY4PQ==</success>

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost >> <iq xmlns="jabber:client" id="75ysdRcSey6iGHEzyvpcGKx" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost << <iq xmlns="jabber:client" to="user_qw3y6c0030@localhost/993927746-tigase-23" type="result" id="75ysdRcSey6iGHEzyvpcGKx"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_qw3y6c0030@localhost/993927746-tigase-23</jid></bind></iq>

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" to="user_qw3y6c0030@localhost/993927746-tigase-23" type="result" id="z6zytnXiTdUi4es06xkVgVf"/>

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

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

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-23 << <enabled id="d072ff8a-96b6-4916-a666-81250a86181b" max="60" location="d4270859fb27" resume="true" xmlns="urn:xmpp:sm:3"/>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-23 >> <iq id="4nkZp1q9JWmcuY2aFAriZn8" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-23 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" from="localhost" to="user_qw3y6c0030@localhost/993927746-tigase-23" type="result" id="x0fRViXlTaDHSeWYWY2p4pe"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" category="server" type="im"/><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 category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-26 18:27:17 | user :: user_qw3y6c0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" to="user_qw3y6c0030@localhost/993927746-tigase-23" type="result" id="4nkZp1q9JWmcuY2aFAriZn8"><query xmlns="jabber:iq:roster"/></iq>

2019-11-26 18:27:17 | Disconnecting

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

2019-11-26 18:27:17 | [Mutex] notify: [disconnected]

2019-11-26 18:27:17 | [Mutex] received everything.

2019-11-26 18:27:19 | [Mutex] waiting for: [user]

2019-11-26 18:27:19 | [Mutex] received everything.

2019-11-26 18:27:19 | [Mutex] isItemNotified: user:ok:true :: true