Test duration: 16.096s
Passed Tests | ||
---|---|---|
tigase.tests.server.TestBruteforcePrevention | ||
testDisableUser | 6.051s |
2019-11-20 19:45:42 |
2019-11-20 19:45:42 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention] 2019-11-20 19:45:42 | ------------------------------------ 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6334a480 2019-11-20 19:45:42 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6faa71af}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6df34696}, 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@69cccff0}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2cce4cad}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6a98fd10}, 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=Wed Nov 20 19:45:42 PST 2019}}}} 2019-11-20 19:45:42 | [Mutex] waiting for: [registration] 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1da8c123 2019-11-20 19:45:42 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6df34696}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@69cccff0}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2cce4cad}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6a98fd10}, 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=Wed Nov 20 19:45:42 PST 2019}}}} 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@12142e29 2019-11-20 19:45:42 | 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-20 19:45:42 | 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-20 19:45:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ce1b3e2} 2019-11-20 19:45:42 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:42 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@613ca713 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3a46d3ce 2019-11-20 19:45:42 | 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-20 19:45:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@910c7c9} 2019-11-20 19:45:42 | 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-20 19:45:42 | user :: null >> <iq to="localhost" id="uorcRP6lVSfVR8GspdMGnaN" type="get"><query xmlns="jabber:iq:register"/></iq> 2019-11-20 19:45:42 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e2636299} 2019-11-20 19:45:42 | user :: null << <iq type="result" xmlns="jabber:client" id="uorcRP6lVSfVR8GspdMGnaN" from="localhost"><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-20 19:45:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@48af0baa} 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@4c2f3993 2019-11-20 19:45:42 | user :: null >> <iq to="localhost" id="YqvYWeVXmRXWnbnaKAFJOKv" type="set"><query xmlns="jabber:iq:register"><username>user_ud1b7x0027</username><password>user_ud1b7x0027</password><email>ad6e69f0-06a6-4a1e-aaf9-a0336ed64787@localhost</email></query></iq> 2019-11-20 19:45:42 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4a886a88} 2019-11-20 19:45:42 | [Mutex] received everything. 2019-11-20 19:45:42 | [Mutex] isItemNotified: registrationSuccess :: true 2019-11-20 19:45:42 | user :: null << <iq type="result" xmlns="jabber:client" id="YqvYWeVXmRXWnbnaKAFJOKv" from="localhost"/> 2019-11-20 19:45:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@407b5b7b} 2019-11-20 19:45:42 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ce1b3e2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@910c7c9]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6df34696}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@69cccff0}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2cce4cad}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6a98fd10}, 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=Wed Nov 20 19:45:42 PST 2019}}}} 2019-11-20 19:45:42 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ce1b3e2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@910c7c9]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6df34696}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@69cccff0}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2cce4cad}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6a98fd10}, 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=Wed Nov 20 19:45:42 PST 2019}}}} 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4f5af232 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7f985228 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4ace1fe9 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@50f42548 2019-11-20 19:45:42 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@48a78606 2019-11-20 19:45:42 | user :: user_ud1b7x0027@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-20 19:45:42 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@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-20 19:45:42 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1IMlJ2bE9VRnFWU05pY0hDS3g1MQ==</auth> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IMlJ2bE9VRnFWU05pY0hDS3g1MVNpTTVOU05aVmhQdVhYVjNOdXc0LHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SDJSdmxPVUZxVlNOaWNIQ0t4NTFTaU01TlNOWlZoUHVYWFYzTnV3NCxwPWl2QXlXWE12UEhKdTdsWXNRK3cvOFp2Q01IZHBDcEMxWEtZeXcxOEg0ZlE9</response> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0wQzNjL25MN2svbDhXV0lrZVZPSEhTdzlMMHdjUDJiNUlIKzR1QUF3VlU4PQ==</success> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" ver="8SAx7sxxLI3422mjAeBbH2oWxJg=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost >> <iq xmlns="jabber:client" id="4FcohZZocutl2cpeViMGEyj" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost << <iq to="user_ud1b7x0027@localhost/993927746-tigase-19" type="result" xmlns="jabber:client" id="4FcohZZocutl2cpeViMGEyj"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_ud1b7x0027@localhost/993927746-tigase-19</jid></bind></iq> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="lzS0gJUP6dqQ2xbOLLyBDhY" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost/993927746-tigase-19 << <iq to="user_ud1b7x0027@localhost/993927746-tigase-19" type="result" xmlns="jabber:client" id="lzS0gJUP6dqQ2xbOLLyBDhY"/> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="KOzetmbOOKMOP6dSLw2qjJU" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost/993927746-tigase-19 << <enabled resume="true" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="f57cc8af-da4d-4f8d-8981-6f74984a8c1c"/> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost/993927746-tigase-19 >> <iq id="Yuz6cKX1u7tYrjDGMENZkMz" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@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-20 19:45:42 | user :: user_ud1b7x0027@localhost/993927746-tigase-19 << <iq to="user_ud1b7x0027@localhost/993927746-tigase-19" type="result" xmlns="jabber:client" id="Yuz6cKX1u7tYrjDGMENZkMz"><query xmlns="jabber:iq:roster"/></iq> 2019-11-20 19:45:42 | Disconnecting 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost/993927746-tigase-19 << <iq to="user_ud1b7x0027@localhost/993927746-tigase-19" type="result" xmlns="jabber:client" id="KOzetmbOOKMOP6dSLw2qjJU" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-20 19:45:42 | user :: user_ud1b7x0027@localhost/993927746-tigase-19 << <presence to="user_ud1b7x0027@localhost" xmlns="jabber:client" from="user_ud1b7x0027@localhost/993927746-tigase-19"><c hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp"/></presence> 2019-11-20 19:45:42 | [Mutex] notify: [disconnected] 2019-11-20 19:45:42 | [Mutex] received everything. 2019-11-20 19:45:42 | [Mutex] waiting for: [event] 2019-11-20 19:45:42 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1YVDFKZ1VxSVNaYkE2SUkxTDNpZg==</auth> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YVDFKZ1VxSVNaYkE2SUkxTDNpZjhKSzRoeXYwdkZZRnpPbXJHVXhaLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WFQxSmdVcUlTWmJBNklJMUwzaWY4Sks0aHl2MHZGWUZ6T21yR1V4WixwPUpLV21FcURGWXVQa3IzR2k0Q2IvbzhkTEpXd1dtNlExMkRjRUYyWDBJMkE9</response> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:43 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:43 | [Mutex] received everything. 2019-11-20 19:45:43 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:43 | [Mutex] waiting for: [event] 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1WVWRHUllicm0xVVBkbjJ6ekFudg==</auth> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WVWRHUllicm0xVVBkbjJ6ekFudkNXdkxWSDlYNHExM3VWNW5EVjBvLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VlVkR1JZYnJtMVVQZG4yenpBbnZDV3ZMVkg5WDRxMTN1VjVuRFYwbyxwPXg1Q0RiU2tCd0MzWGNLRUMrZVJiQ0tnRzJ2QjNIYnkyeU4vd3MyWk1keVU9</response> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:43 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:43 | [Mutex] received everything. 2019-11-20 19:45:43 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:43 | [Mutex] waiting for: [event] 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj15dnFyaWpTNGdCS042QUtrblF1Ng==</auth> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15dnFyaWpTNGdCS042QUtrblF1NndRYkZtTkFmckg4MGhLOUsyZ29MLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eXZxcmlqUzRnQktONkFLa25RdTZ3UWJGbU5BZnJIODBoSzlLMmdvTCxwPVkvdFBzMm4vQ3cwVno4MnpjNDVjb2loNkhMN0htK3p3ZExNRDNVVXFaYnc9</response> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:43 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:43 | [Mutex] received everything. 2019-11-20 19:45:43 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:43 | [Mutex] notify: [event, disconnected] 2019-11-20 19:45:43 | [Mutex] waiting for: [event] 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1BeFh3S1FKQWtFSXEyOHF0cUVHZg==</auth> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BeFh3S1FKQWtFSXEyOHF0cUVHZmlKS2RVZFg2cVZBWm9rb0VyUHd6LHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QXhYd0tRSkFrRUlxMjhxdHFFR2ZpSktkVWRYNnFWQVpva29FclB3eixwPTNSN3QzWFA3TnphSnZnUGlyTTlzTnA2ZkR6UjlYTlNpSWFQTzlkMFhGekE9</response> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:43 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:43 | [Mutex] received everything. 2019-11-20 19:45:43 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:43 | [Mutex] waiting for: [event] 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj13U01lcHc2S1BaNHIzVENmMU5uMQ==</auth> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13U01lcHc2S1BaNHIzVENmMU5uMXVWeFZ4QU9mZjdHRTFIZHZRVnhGLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d1NNZXB3NktQWjRyM1RDZjFObjF1VnhWeEFPZmY3R0UxSGR2UVZ4RixwPVRKaGxKb0tvSEg1N3NFb2tMelRmeW1zZXJEQ2FmYjVvdE42YStvazBJN3c9</response> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:43 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:43 | [Mutex] received everything. 2019-11-20 19:45:43 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:43 | [Mutex] waiting for: [event] 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj03VWlKa2hCaW01OHJEcERKZUg2MA==</auth> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03VWlKa2hCaW01OHJEcERKZUg2MFRsVDliY1JmZW5EMXhuTGNaT3VtLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N1VpSmtoQmltNThyRHBESmVINjBUbFQ5YmNSZmVuRDF4bkxjWk91bSxwPWY2RUlKdkJVNXRxMzNNV0tVMG5TU25adkpIRm4wUTdPRDlZVmpxSHhaMzQ9</response> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:43 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:43 | [Mutex] received everything. 2019-11-20 19:45:43 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:43 | [Mutex] waiting for: [event] 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@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-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1yeUN1ZXl2MHZlWU05U2RkN0dScg==</auth> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yeUN1ZXl2MHZlWU05U2RkN0dScjlIYjd3cmJ1SllyTTJaajVtT0wzLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:43 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cnlDdWV5djB2ZVlNOVNkZDdHUnI5SGI3d3JidUpZck0yWmo1bU9MMyxwPVU0RFdEYXNrcnRndWllWFM5aUhtNEZkeDR4Q3R1dVpvV3Bvbm5vMGdFams9</response> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:44 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:44 | [Mutex] received everything. 2019-11-20 19:45:44 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:44 | [Mutex] waiting for: [event] 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1RZVFyNlhsY0xXRHZEV1ZmMHRrbw==</auth> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RZVFyNlhsY0xXRHZEV1ZmMHRrb3hkd291S216ZFhSWjVadXgyYmloLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UWVRcjZYbGNMV0R2RFdWZjB0a294ZHdvdUttemRYUlo1WnV4MmJpaCxwPUdNYVo3Zzc1Rkp4SDBxVnN4dXdKRmJtbzY2djZyT0NGUlQ5ck42OUIrbEU9</response> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:44 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:44 | [Mutex] notify: [event, disconnected] 2019-11-20 19:45:44 | [Mutex] received everything. 2019-11-20 19:45:44 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:44 | [Mutex] waiting for: [event] 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj0yN1ZTVVI4OFVYeXMyM0p0RVpxbw==</auth> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yN1ZTVVI4OFVYeXMyM0p0RVpxb0JIRlViclpIZnllemsxZ2ZWOHBFLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MjdWU1VSODhVWHlzMjNKdEVacW9CSEZVYnJaSGZ5ZXprMWdmVjhwRSxwPWpYdUk3NGhzZlh1QXVrUE52bE9rMy9EeWdTSVZlT3BFdUFzUkE4ZVNLems9</response> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:44 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:44 | [Mutex] received everything. 2019-11-20 19:45:44 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:44 | [Mutex] waiting for: [event] 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1FUTZoa2czQ240ZHBqODNxcUFMbw==</auth> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FUTZoa2czQ240ZHBqODNxcUFMbzRDSmF1SUpIaHlDWlhKTVBBWUJSLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RVE2aGtnM0NuNGRwajgzcXFBTG80Q0phdUlKSGh5Q1pYSk1QQVlCUixwPXJkZnVLQ1F5VXo3ZmhiUFB4TWdMVkJvUjJxMTFudzNRRmk0ZmsxU0dHYms9</response> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:44 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:44 | [Mutex] received everything. 2019-11-20 19:45:44 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:44 | [Mutex] waiting for: [event] 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1jZ3lQUkw5d2hjMmN0UlFvSW5reA==</auth> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jZ3lQUkw5d2hjMmN0UlFvSW5reHdTenBMdEpLTFY4c2lRaHA5eGNVLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y2d5UFJMOXdoYzJjdFJRb0lua3h3U3pwTHRKS0xWOHNpUWhwOXhjVSxwPXhTb3lYVzdmM29LUGxLUDZoVzBUSzdIYzc4QUtEZlNYYUd1SEQ2UFVKWkk9</response> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:44 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:44 | [Mutex] notify: [event, disconnected] 2019-11-20 19:45:44 | [Mutex] received everything. 2019-11-20 19:45:44 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:44 | [Mutex] waiting for: [event] 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1WaDB2NUFWQmZtRnM0TVFtR3A3eQ==</auth> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WaDB2NUFWQmZtRnM0TVFtR3A3eUVEZHFRemh0OGlhQkdXNk1ZdTdMLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VmgwdjVBVkJmbUZzNE1RbUdwN3lFRGRxUXpodDhpYUJHVzZNWXU3TCxwPUVoRDhMY3dtYnlNOFFBek9Lc0xQV1BXWldGQWwzQmdFck0rR2VsaXJXemM9</response> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:44 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:44 | [Mutex] received everything. 2019-11-20 19:45:44 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:44 | [Mutex] notify: [event, disconnected] 2019-11-20 19:45:44 | [Mutex] waiting for: [event] 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1UVTB6TjIwdFc3M1FCejZ6WFY0ag==</auth> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UVTB6TjIwdFc3M1FCejZ6WFY0anRRbGlkTk5NRU44dWpRVXBpcnphLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VFUwek4yMHRXNzNRQno2elhWNGp0UWxpZE5OTUVOOHVqUVVwaXJ6YSxwPS9pVGZvTHVYeXFPNlZSTnYvcDZUNmp5YTJIamVCRkNXeE54cjZnVVdTOHc9</response> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:44 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:44 | [Mutex] received everything. 2019-11-20 19:45:44 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:44 | [Mutex] waiting for: [event] 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@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-20 19:45:44 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1YcW1XbkxNdDRaTmh1SFVoWm9HRQ==</auth> 2019-11-20 19:45:44 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YcW1XbkxNdDRaTmh1SFVoWm9HRTNySkVrZ0I1Wm16eUdqZUY3eWVCLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WHFtV25MTXQ0Wk5odUhVaFpvR0UzckpFa2dCNVptenlHamVGN3llQixwPVRhSjErWVUrMzFRMFozMXQvTnpxcmdpOFV4c2NQcFZCcFFlTUFHTHhwc1U9</response> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:45 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:45 | [Mutex] received everything. 2019-11-20 19:45:45 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:45 | [Mutex] notify: [event, disconnected] 2019-11-20 19:45:45 | [Mutex] waiting for: [event] 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1UVVgyWlFQNXNDQ2ROYjhNRDdpWg==</auth> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UVVgyWlFQNXNDQ2ROYjhNRDdpWk1nU3kwUEpKaUZseGtteFFIWFVELHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VFVYMlpRUDVzQ0NkTmI4TUQ3aVpNZ1N5MFBKSmlGbHhrbXhRSFhVRCxwPU1UeFBPakFWN2g3c1JBWXhHTnJzVDAySVk0N3JFd3c1TFY0ZUR2cnkvdFE9</response> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:45 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:45 | [Mutex] received everything. 2019-11-20 19:45:45 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:45 | [Mutex] waiting for: [event] 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1UR0NzOFIxdE51eDVWVHdFUFhQeQ==</auth> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UR0NzOFIxdE51eDVWVHdFUFhQeUNtTUJBMEZxUjNQYkxrZW5MUVltLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VEdDczhSMXROdXg1VlR3RVBYUHlDbU1CQTBGcVIzUGJMa2VuTFFZbSxwPWJodENCNm1PQlltb3hHQ0htcGxDM0cwMEsvbzVJQlMzQTQrMzRGVzdoajA9</response> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:45 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:45 | [Mutex] received everything. 2019-11-20 19:45:45 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:45 | [Mutex] waiting for: [event] 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1SM1lPN3hPOHVaMEZoaHYzZnpEMQ==</auth> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SM1lPN3hPOHVaMEZoaHYzZnpEMXJxNHRkdlkzMG01a1VReU4xYzlWLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UjNZTzd4Tzh1WjBGaGh2M2Z6RDFycTR0ZHZZMzBtNWtVUXlOMWM5VixwPVJtb1FnUTNSbHhGZXJsRFZySm9TZmh2MmRqSi9iWmhqb3VMaG5kekYvWE09</response> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:45 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:45 | [Mutex] received everything. 2019-11-20 19:45:45 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:45 | [Mutex] waiting for: [event] 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1ZSkU5cE1jMUo5YjFReng0dVlZUw==</auth> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZSkU5cE1jMUo5YjFReng0dVlZU0R2dmMzUXI0WU1aRUdsVlFBRTM2LHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WUpFOXBNYzFKOWIxUXp4NHVZWVNEdnZjM1FyNFlNWkVHbFZRQUUzNixwPXpRb3NPdkJmTHRERVBuOWZjaEs4TCt5K2tmMXA1NFdiRmVadmRPT3cwY0k9</response> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:45 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:45 | [Mutex] received everything. 2019-11-20 19:45:45 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:45 | [Mutex] waiting for: [event] 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1wck56Sk9uZDdhdVYybEw4b1JmeQ==</auth> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wck56Sk9uZDdhdVYybEw4b1JmeXRJWHZRWVZvN1dnUGtkWWQySzdQLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cHJOekpPbmQ3YXVWMmxMOG9SZnl0SVh2UVlWbzdXZ1BrZFlkMks3UCxwPU42akJIRmtKV3lJdHdNWEsxcWYzeUFjSGpmNUVIYW5iR3MzVFVtRVJ3U1E9</response> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:45 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:45 | [Mutex] notify: [event, disconnected] 2019-11-20 19:45:45 | [Mutex] received everything. 2019-11-20 19:45:45 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:45 | [Mutex] waiting for: [event] 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1tZ1RqRnlEWG1ZU1ZQcmNVemxacw==</auth> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tZ1RqRnlEWG1ZU1ZQcmNVemxac3c2UzJKRDJmVnZiOGFPbHVEZjE5LHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bWdUakZ5RFhtWVNWUHJjVXpsWnN3NlMySkQyZlZ2YjhhT2x1RGYxOSxwPVBuT0JyV2tsTjcwRllFWVhiUjB1UmNBR2c4b0Y0RENCT0JtT3RNQmZuc1U9</response> 2019-11-20 19:45:45 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:45 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:45 | [Mutex] notify: [event, disconnected] 2019-11-20 19:45:45 | [Mutex] received everything. 2019-11-20 19:45:45 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:45 | [Mutex] waiting for: [event] 2019-11-20 19:45:45 | user :: user_ud1b7x0027@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-20 19:45:45 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:46 | user :: user_ud1b7x0027@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-20 19:45:46 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj1PeXVWaFdUN3N6MEFVWlNnMnNXMw==</auth> 2019-11-20 19:45:46 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PeXVWaFdUN3N6MEFVWlNnMnNXM0RibVI5ZDIwMGxnUEo3dkJ0TEhwLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:46 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T3l1VmhXVDdzejBBVVpTZzJzVzNEYm1SOWQyMDBsZ1BKN3ZCdExIcCxwPURBN3pyOW83MXVmdDVKVTF4MWZSdkJkTVE4NXE3YXdDQ2lIelRkYjlvb289</response> 2019-11-20 19:45:46 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:46 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:46 | [Mutex] notify: [event, disconnected] 2019-11-20 19:45:46 | [Mutex] received everything. 2019-11-20 19:45:46 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:46 | user :: user_ud1b7x0027@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-20 19:45:46 | user :: user_ud1b7x0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:46 | user :: user_ud1b7x0027@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-20 19:45:46 | user :: user_ud1b7x0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3VkMWI3eDAwMjcscj0zaU9ibm95b083S1hpbERmQzVPNA==</auth> 2019-11-20 19:45:46 | user :: user_ud1b7x0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zaU9ibm95b083S1hpbERmQzVPNHhrRm1SQklPYlFROHZvVTFYYVNvLHM9eTZKbWlxbzl2dzhqV0E9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:46 | user :: user_ud1b7x0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M2lPYm5veW9PN0tYaWxEZkM1TzR4a0ZtUkJJT2JRUTh2b1UxWGFTbyxwPW5SWTBnL243SlZwY2R4VGJoTUxBWDYwT0F6QVBINTZ0M1c4QnpPdzkySVU9</response> 2019-11-20 19:45:46 | user :: user_ud1b7x0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: user_ud1b7x0027@localhost is not authorized to act as user_ud1b7x0027@localhost</text></failure> 2019-11-20 19:45:48 | [Mutex] waiting for: [user] 2019-11-20 19:45:48 | [Mutex] received everything. 2019-11-20 19:45:48 | [Mutex] isItemNotified: user:ok:false :: true |
testOneInvalidLoginTooMuchDefaultSasl | 3.263s |
2019-11-20 19:45:48 |
2019-11-20 19:45:48 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention] 2019-11-20 19:45:48 | ------------------------------------ 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@73c5971e 2019-11-20 19:45:48 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6faa71af}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7d026716}, 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@793dfc6e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3c3f6d2d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@631d60d3}, 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=Wed Nov 20 19:45:48 PST 2019}}}} 2019-11-20 19:45:48 | [Mutex] waiting for: [registration] 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@dc99171 2019-11-20 19:45:48 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7d026716}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@793dfc6e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3c3f6d2d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@631d60d3}, 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=Wed Nov 20 19:45:48 PST 2019}}}} 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@1b01c22a 2019-11-20 19:45:48 | 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-20 19:45:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5c109262} 2019-11-20 19:45:48 | 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-20 19:45:48 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:48 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@54037acb 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@15002b23 2019-11-20 19:45:48 | 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-20 19:45:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5ab3b} 2019-11-20 19:45:48 | 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-20 19:45:48 | user :: null >> <iq to="localhost" id="XYVPEiWlN2dFmdRJSaql5wa" type="get"><query xmlns="jabber:iq:register"/></iq> 2019-11-20 19:45:48 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@93592b3b} 2019-11-20 19:45:48 | user :: null << <iq type="result" xmlns="jabber:client" id="XYVPEiWlN2dFmdRJSaql5wa" from="localhost"><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-20 19:45:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@585eaadb} 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@17c44639 2019-11-20 19:45:48 | user :: null >> <iq to="localhost" id="XZWRIqcRP6lVSfVR8GspdMG" type="set"><query xmlns="jabber:iq:register"><username>user_kf349e0028</username><password>user_kf349e0028</password><email>583297ec-b570-41ff-b6ce-021c3c9f9a4f@localhost</email></query></iq> 2019-11-20 19:45:48 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@44096223} 2019-11-20 19:45:48 | user :: null << <iq type="result" xmlns="jabber:client" id="XZWRIqcRP6lVSfVR8GspdMG" from="localhost"/> 2019-11-20 19:45:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3893ed1} 2019-11-20 19:45:48 | [Mutex] received everything. 2019-11-20 19:45:48 | [Mutex] isItemNotified: registrationSuccess :: true 2019-11-20 19:45:48 | 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;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5c109262, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5ab3b]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7d026716}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@793dfc6e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3c3f6d2d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@631d60d3}, 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=Wed Nov 20 19:45:48 PST 2019}}}} 2019-11-20 19:45:48 | 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;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5c109262, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5ab3b]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7d026716}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@793dfc6e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3c3f6d2d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@631d60d3}, 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=Wed Nov 20 19:45:48 PST 2019}}}} 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2ef801e8 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@3dd6e9e 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@369d0552 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7c28cae6 2019-11-20 19:45:48 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@12b163ca 2019-11-20 19:45:48 | user :: user_kf349e0028@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-20 19:45:48 | user :: user_kf349e0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:48 | user :: user_kf349e0028@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-20 19:45:48 | user :: user_kf349e0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tmMzQ5ZTAwMjgscj01WmwxUmxQeEJIdXJSaWxERGZQbw==</auth> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01WmwxUmxQeEJIdXJSaWxERGZQb09qV1JyYmp2MktJZEtmbnJCZ2ZVLHM9UFdKMzFtUzdFYTJqYlE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NVpsMVJsUHhCSHVyUmlsRERmUG9PaldScmJqdjJLSWRLZm5yQmdmVSxwPUVUK0sxeWNDRDZWRnJSdnVXalNmVkJTdGp6YVh2UUx3a0cwbFVtb1dUYlk9</response> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1JY0JKTWtFRndRVjFIZTJ3OU5wWHFyN0UrMFJDejBacmlDQTgyRkt2NUk0PQ==</success> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" ver="8SAx7sxxLI3422mjAeBbH2oWxJg=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost >> <iq xmlns="jabber:client" id="r0XTMysnRatbohZZocutl2c" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost << <iq to="user_kf349e0028@localhost/993927746-tigase-20" type="result" xmlns="jabber:client" id="r0XTMysnRatbohZZocutl2c"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_kf349e0028@localhost/993927746-tigase-20</jid></bind></iq> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="SRucBEj49iAwv7Gvfwxv1sk" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost/993927746-tigase-20 << <iq to="user_kf349e0028@localhost/993927746-tigase-20" type="result" xmlns="jabber:client" id="SRucBEj49iAwv7Gvfwxv1sk"/> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="vWHPLY5pQbNBCEohXgEj2xw" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost/993927746-tigase-20 << <enabled resume="true" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="8de7f20d-10cc-4f70-b780-3bd7e4e7d044"/> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost/993927746-tigase-20 >> <iq id="BDKXlHO2aP3s25ADICm0gJU" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-20 19:45:48 | user :: user_kf349e0028@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-20 19:45:48 | user :: user_kf349e0028@localhost/993927746-tigase-20 << <iq to="user_kf349e0028@localhost/993927746-tigase-20" type="result" xmlns="jabber:client" id="vWHPLY5pQbNBCEohXgEj2xw" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-20 19:45:48 | user :: user_kf349e0028@localhost/993927746-tigase-20 << <iq to="user_kf349e0028@localhost/993927746-tigase-20" type="result" xmlns="jabber:client" id="BDKXlHO2aP3s25ADICm0gJU"><query xmlns="jabber:iq:roster"/></iq> 2019-11-20 19:45:49 | Disconnecting 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost/993927746-tigase-20 << <presence to="user_kf349e0028@localhost" xmlns="jabber:client" from="user_kf349e0028@localhost/993927746-tigase-20"><c hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp"/></presence> 2019-11-20 19:45:49 | [Mutex] notify: [disconnected] 2019-11-20 19:45:49 | [Mutex] received everything. 2019-11-20 19:45:49 | [Mutex] waiting for: [event] 2019-11-20 19:45:49 | user :: user_kf349e0028@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-20 19:45:49 | user :: user_kf349e0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:49 | user :: user_kf349e0028@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-20 19:45:49 | user :: user_kf349e0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tmMzQ5ZTAwMjgscj1qcHloWHpaT3BJaksxM3RQeEF3VA==</auth> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qcHloWHpaT3BJaksxM3RQeEF3VGR1S2huZDJRdHhkZXRnWkFtTVRzLHM9UFdKMzFtUzdFYTJqYlE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9anB5aFh6Wk9wSWpLMTN0UHhBd1RkdUtobmQyUXR4ZGV0Z1pBbU1UcyxwPTg3cXBqbjgxaFpaT1U1UjVBcU5LMllwMkRBT240VVZyVU9WSDNBRmJNT1U9</response> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:49 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:49 | [Mutex] received everything. 2019-11-20 19:45:49 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:49 | [Mutex] waiting for: [event] 2019-11-20 19:45:49 | user :: user_kf349e0028@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-20 19:45:49 | user :: user_kf349e0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:49 | user :: user_kf349e0028@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-20 19:45:49 | user :: user_kf349e0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tmMzQ5ZTAwMjgscj1RQVhXTllKRnU2TE1YOVQxdGo2Mw==</auth> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RQVhXTllKRnU2TE1YOVQxdGo2MzNFWEx2a3Y2T0ptOHVYa3BCQUtYLHM9UFdKMzFtUzdFYTJqYlE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UUFYV05ZSkZ1NkxNWDlUMXRqNjMzRVhMdmt2Nk9KbTh1WGtwQkFLWCxwPTNIOVc3TnR5ckYxR3Vxcm1pak5Uak1pamIzRjRJVzZVdm5rR0V5YlF2SWc9</response> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:49 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:49 | [Mutex] received everything. 2019-11-20 19:45:49 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:49 | [Mutex] waiting for: [event] 2019-11-20 19:45:49 | user :: user_kf349e0028@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-20 19:45:49 | user :: user_kf349e0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:49 | user :: user_kf349e0028@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-20 19:45:49 | user :: user_kf349e0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tmMzQ5ZTAwMjgscj1jOW55QVZENWlxVEhraXhCT3MwNg==</auth> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jOW55QVZENWlxVEhraXhCT3MwNms0M1c2bUF4dXJNUDNQYjRMOWlBLHM9UFdKMzFtUzdFYTJqYlE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YzlueUFWRDVpcVRIa2l4Qk9zMDZrNDNXNm1BeHVyTVAzUGI0TDlpQSxwPW5pNGxFUnFUd0pQb05BRWRNeWZrQlRzUGYvdXQ0c3dFUG1uOERvNjBJZG89</response> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:49 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:49 | [Mutex] received everything. 2019-11-20 19:45:49 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:49 | [Mutex] notify: [event, disconnected] 2019-11-20 19:45:49 | [Mutex] waiting for: [event] 2019-11-20 19:45:49 | user :: user_kf349e0028@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-20 19:45:49 | user :: user_kf349e0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:49 | user :: user_kf349e0028@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-20 19:45:49 | user :: user_kf349e0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tmMzQ5ZTAwMjgscj1tR1ZLSTJObFBtOUtrd21JUG42Wg==</auth> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tR1ZLSTJObFBtOUtrd21JUG42WlpsMHNxR3dyT0s0NTFUaTE1WTdLLHM9UFdKMzFtUzdFYTJqYlE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bUdWS0kyTmxQbTlLa3dtSVBuNlpabDBzcUd3ck9LNDUxVGkxNVk3SyxwPVhTNUE5b2JUQzQ1TTNmUStRQkVybDdoSGhHcnBnc2lmNDZZaWtURGdrQTA9</response> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:49 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:49 | [Mutex] received everything. 2019-11-20 19:45:49 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:49 | user :: user_kf349e0028@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-20 19:45:49 | user :: user_kf349e0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:49 | user :: user_kf349e0028@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-20 19:45:49 | user :: user_kf349e0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2tmMzQ5ZTAwMjgscj1LOVZSc0xIcFFKN3ZnS0VNMkpqYg==</auth> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LOVZSc0xIcFFKN3ZnS0VNMkpqYkVOTk5sRzBpTW9tZ3BhSTdaNXIxLHM9UFdKMzFtUzdFYTJqYlE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SzlWUnNMSHBRSjd2Z0tFTTJKamJFTk5ObEcwaU1vbWdwYUk3WjVyMSxwPWQ4em5nSmNWZllZSVkyNllDQUFWWTNBR2lJOXBFVmpvczZkZS9qb0J1TFk9</response> 2019-11-20 19:45:49 | user :: user_kf349e0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:51 | [Mutex] waiting for: [user] 2019-11-20 19:45:51 | [Mutex] received everything. 2019-11-20 19:45:51 | [Mutex] isItemNotified: user:ok:true :: true |
testOneInvalidLoginTooMuchRandomSasl | 3.356s |
2019-11-20 19:45:51 |
2019-11-20 19:45:51 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention] 2019-11-20 19:45:51 | ------------------------------------ 2019-11-20 19:45:51 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@41c4ec97 2019-11-20 19:45:51 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6faa71af}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4f030adf}, 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@4b3c87e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@e3e00e4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6878f5e0}, 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=Wed Nov 20 19:45:51 PST 2019}}}} 2019-11-20 19:45:51 | [Mutex] waiting for: [registration] 2019-11-20 19:45:51 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3f7a4fc2 2019-11-20 19:45:51 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4f030adf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@4b3c87e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@e3e00e4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6878f5e0}, 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=Wed Nov 20 19:45:51 PST 2019}}}} 2019-11-20 19:45:51 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@10d6e475 2019-11-20 19:45:51 | 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-20 19:45:51 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6e11ffab} 2019-11-20 19:45:51 | 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-20 19:45:51 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:51 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2019-11-20 19:45:51 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@41e9c07c 2019-11-20 19:45:51 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2c8083dc 2019-11-20 19:45:51 | 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-20 19:45:51 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@bd22f75} 2019-11-20 19:45:51 | 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-20 19:45:51 | user :: null >> <iq to="localhost" id="gFKSdSW0iQTetoNAaGPLY5p" type="get"><query xmlns="jabber:iq:register"/></iq> 2019-11-20 19:45:51 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4160dd2c} 2019-11-20 19:45:51 | user :: null << <iq type="result" xmlns="jabber:client" id="gFKSdSW0iQTetoNAaGPLY5p" from="localhost"><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-20 19:45:51 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6a5f6503} 2019-11-20 19:45:51 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@653aa214 2019-11-20 19:45:51 | user :: null >> <iq to="localhost" id="YGLuYi3dST14DHpeSQbLSSL" type="set"><query xmlns="jabber:iq:register"><username>user_7whwzq0029</username><password>user_7whwzq0029</password><email>a30badb7-ab0e-4182-9b13-c11afca2e043@localhost</email></query></iq> 2019-11-20 19:45:51 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e784d3d1} 2019-11-20 19:45:52 | user :: null << <iq type="result" xmlns="jabber:client" id="YGLuYi3dST14DHpeSQbLSSL" from="localhost"/> 2019-11-20 19:45:52 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4d0c430c} 2019-11-20 19:45:52 | [Mutex] received everything. 2019-11-20 19:45:52 | [Mutex] isItemNotified: registrationSuccess :: true 2019-11-20 19:45:52 | 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;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6e11ffab, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@bd22f75]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4f030adf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@4b3c87e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@e3e00e4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6878f5e0}, 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=Wed Nov 20 19:45:52 PST 2019}}}} 2019-11-20 19:45:52 | 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;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6e11ffab, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@bd22f75]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4f030adf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@4b3c87e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@e3e00e4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6878f5e0}, 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=Wed Nov 20 19:45:52 PST 2019}}}} 2019-11-20 19:45:52 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@573f645f 2019-11-20 19:45:52 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@46d974c6 2019-11-20 19:45:52 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@76c3540b 2019-11-20 19:45:52 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@59f86dfc 2019-11-20 19:45:52 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@75c9e700 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzd3aHd6cTAwMjkscj11aFZrbDFjRE8wNWFiZmJHZ2NKRA==</auth> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11aFZrbDFjRE8wNWFiZmJHZ2NKRHZvT29wdUZjVjFyUTRZODl1RG1zLHM9eW9XUzEyMXU4VnROTnc9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWhWa2wxY0RPMDVhYmZiR2djSkR2b09vcHVGY1YxclE0WTg5dURtcyxwPU5adVpsQmh4Q2lrNjBlWTE4c1dVTE56YktQYmc4RktQQnBEL3RYK3E1Tmc9</response> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1pSzR6UjFUaWlZSGtWbGR5dmxyS3dRUThWdWl0WGpGcmhNZit5QUcxQVFNPQ==</success> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" ver="8SAx7sxxLI3422mjAeBbH2oWxJg=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost >> <iq xmlns="jabber:client" id="F6ZmO7DCmJSdSW0iQTetoNA" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <iq to="user_7whwzq0029@localhost/993927746-tigase-21" type="result" xmlns="jabber:client" id="F6ZmO7DCmJSdSW0iQTetoNA"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_7whwzq0029@localhost/993927746-tigase-21</jid></bind></iq> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="BJQ9Jtm8mdP08hYpgIyo2h0" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost/993927746-tigase-21 << <iq to="user_7whwzq0029@localhost/993927746-tigase-21" type="result" xmlns="jabber:client" id="BJQ9Jtm8mdP08hYpgIyo2h0"/> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="wbapgFzaP5bMY2zxqYXk7Gy" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost/993927746-tigase-21 << <enabled resume="true" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="3959e7c0-70b8-42ba-a7a3-09b271d932a6"/> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost/993927746-tigase-21 >> <iq id="Xb8fuYi3dST14DHpeSQbLSS" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost/993927746-tigase-21 << <iq to="user_7whwzq0029@localhost/993927746-tigase-21" type="result" xmlns="jabber:client" id="wbapgFzaP5bMY2zxqYXk7Gy" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost/993927746-tigase-21 << <iq to="user_7whwzq0029@localhost/993927746-tigase-21" type="result" xmlns="jabber:client" id="Xb8fuYi3dST14DHpeSQbLSS"><query xmlns="jabber:iq:roster"/></iq> 2019-11-20 19:45:52 | Disconnecting 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost/993927746-tigase-21 << <presence to="user_7whwzq0029@localhost" xmlns="jabber:client" from="user_7whwzq0029@localhost/993927746-tigase-21"><c hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp"/></presence> 2019-11-20 19:45:52 | [Mutex] notify: [disconnected] 2019-11-20 19:45:52 | [Mutex] received everything. 2019-11-20 19:45:52 | [Mutex] waiting for: [event] 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzd3aHd6cTAwMjkscj03MGhIMTFVcW1uWHBrZmRkZUpWYg==</auth> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03MGhIMTFVcW1uWHBrZmRkZUpWYmJyQUZNd1JIUkQ1ek80UHdwWTBaLHM9eW9XUzEyMXU4VnROTnc9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NzBoSDExVXFtblhwa2ZkZGVKVmJickFGTXdSSFJENXpPNFB3cFkwWixwPXpHaHVpd2R3dEkvclA4Y290Yk52NTJLdFJqQVNrTDdoclJKR2MyaUhBOU09</response> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:52 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:52 | [Mutex] received everything. 2019-11-20 19:45:52 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:52 | [Mutex] waiting for: [event] 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzd3aHd6cTAwMjkscj0zZlRYNVhQa2N4cUZDS1VsbUI3Zg==</auth> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zZlRYNVhQa2N4cUZDS1VsbUI3ZkIzdElUV2d2bWR5aDF4U0hSMHRQLHM9eW9XUzEyMXU4VnROTnc9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M2ZUWDVYUGtjeHFGQ0tVbG1CN2ZCM3RJVFdndm1keWgxeFNIUjB0UCxwPVdmZEo1LzlaQS9vc002VFNBYXR0My9Db3pWVHNlcW1XUXhyUlJYbXU0ams9</response> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:52 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:52 | [Mutex] received everything. 2019-11-20 19:45:52 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:52 | [Mutex] notify: [event, disconnected] 2019-11-20 19:45:52 | [Mutex] waiting for: [event] 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyXzd3aHd6cTAwMjkscj1KSVlKdW0xeE8yUXpNbm01Q0EwWA==</auth> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KSVlKdW0xeE8yUXpNbm01Q0EwWHc3ajNNUlhuQkY5R1FYSElnSVNPLHM9azRwaTcxRmtRZ0wzL3c9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SklZSnVtMXhPMlF6TW5tNUNBMFh3N2ozTVJYbkJGOUdRWEhJZ0lTTyxwPUxFZ1dlQXFnc0hrbnFFTnNvN0hWd3lheE0yQT0=</response> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:52 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:52 | [Mutex] received everything. 2019-11-20 19:45:52 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:52 | [Mutex] waiting for: [event] 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:52 | user :: user_7whwzq0029@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-20 19:45:52 | user :: user_7whwzq0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyXzd3aHd6cTAwMjkscj0xN2g3aVZrbWtMYkhNZWNTZ1BWcg==</auth> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xN2g3aVZrbWtMYkhNZWNTZ1BWcjNCcHFqUlBpVHhIR2xUSVlBZ0RULHM9azRwaTcxRmtRZ0wzL3c9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MTdoN2lWa21rTGJITWVjU2dQVnIzQnBxalJQaVR4SEdsVElZQWdEVCxwPXBLRXJOSmdpRVpPQmw5TkMvNCtRRG5FRXNIVT0=</response> 2019-11-20 19:45:52 | user :: user_7whwzq0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:52 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:52 | [Mutex] received everything. 2019-11-20 19:45:52 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:53 | user :: user_7whwzq0029@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-20 19:45:53 | user :: user_7whwzq0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:53 | user :: user_7whwzq0029@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-20 19:45:53 | user :: user_7whwzq0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzd3aHd6cTAwMjkscj1iUE9hMjN2MjBSYVFLOEl1UURxQg==</auth> 2019-11-20 19:45:53 | user :: user_7whwzq0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iUE9hMjN2MjBSYVFLOEl1UURxQnpaQ2lXUlhGOW1ZVVhNMTY1djVSLHM9eW9XUzEyMXU4VnROTnc9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:53 | user :: user_7whwzq0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YlBPYTIzdjIwUmFRSzhJdVFEcUJ6WkNpV1JYRjltWVVYTTE2NXY1UixwPTFXODZTRzB0Z1pJQlJnbEp0UGlFQWpVWGhZbndxMUlnR2d6RmxjaFV4STg9</response> 2019-11-20 19:45:53 | user :: user_7whwzq0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:55 | [Mutex] waiting for: [user] 2019-11-20 19:45:55 | [Mutex] received everything. 2019-11-20 19:45:55 | [Mutex] isItemNotified: user:ok:true :: true |
testThreeInvalidLogins | 3.091s |
2019-11-20 19:45:55 |
2019-11-20 19:45:55 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention] 2019-11-20 19:45:55 | ------------------------------------ 2019-11-20 19:45:55 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@230559ba 2019-11-20 19:45:55 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6faa71af}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2dc2a3aa}, 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@29fd32ca}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6cffa991}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@653ef53d}, 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=Wed Nov 20 19:45:55 PST 2019}}}} 2019-11-20 19:45:55 | [Mutex] waiting for: [registration] 2019-11-20 19:45:55 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5d59c5c3 2019-11-20 19:45:55 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2dc2a3aa}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@29fd32ca}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6cffa991}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@653ef53d}, 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=Wed Nov 20 19:45:55 PST 2019}}}} 2019-11-20 19:45:55 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@1d72c7c0 2019-11-20 19:45:55 | 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-20 19:45:55 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@cd056de} 2019-11-20 19:45:55 | 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-20 19:45:55 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:55 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2019-11-20 19:45:55 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1e55dd64 2019-11-20 19:45:55 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@db174b0 2019-11-20 19:45:55 | 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-20 19:45:55 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@676ee01} 2019-11-20 19:45:55 | 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-20 19:45:55 | user :: null >> <iq to="localhost" id="UZskFMz8gSdxwbBeXlHO2aP" type="get"><query xmlns="jabber:iq:register"/></iq> 2019-11-20 19:45:55 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@581dff52} 2019-11-20 19:45:55 | user :: null << <iq type="result" xmlns="jabber:client" id="UZskFMz8gSdxwbBeXlHO2aP" from="localhost"><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-20 19:45:55 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@89e2eb7} 2019-11-20 19:45:55 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@38907c3d 2019-11-20 19:45:55 | user :: null >> <iq to="localhost" id="S5IEvsViBco8JzAjRKZpP4y" type="set"><query xmlns="jabber:iq:register"><username>user_wk60nl0030</username><password>user_wk60nl0030</password><email>f2097f98-1afb-46bc-b65d-f0351e929b18@localhost</email></query></iq> 2019-11-20 19:45:55 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c36f181b} 2019-11-20 19:45:55 | user :: null << <iq type="result" xmlns="jabber:client" id="S5IEvsViBco8JzAjRKZpP4y" from="localhost"/> 2019-11-20 19:45:55 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3e829b6b} 2019-11-20 19:45:55 | [Mutex] received everything. 2019-11-20 19:45:55 | [Mutex] isItemNotified: registrationSuccess :: true 2019-11-20 19:45:55 | 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;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@cd056de, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@676ee01]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2dc2a3aa}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@29fd32ca}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6cffa991}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@653ef53d}, 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=Wed Nov 20 19:45:55 PST 2019}}}} 2019-11-20 19:45:55 | 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;@6faa71af}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@cd056de, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@676ee01]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2dc2a3aa}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6cd5bfe3}, 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@29fd32ca}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6cffa991}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@653ef53d}, 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=Wed Nov 20 19:45:55 PST 2019}}}} 2019-11-20 19:45:55 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@f357c5c 2019-11-20 19:45:55 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@76a7109b 2019-11-20 19:45:55 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4d6debe6 2019-11-20 19:45:55 | user :: user_wk60nl0030@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-20 19:45:55 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@671e78e3 2019-11-20 19:45:55 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@43ed3fc0 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:55 | user :: user_wk60nl0030@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-20 19:45:55 | user :: user_wk60nl0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3drNjBubDAwMzAscj1EcWF5ZkZzQVRzUjRma1daUFVPTg==</auth> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EcWF5ZkZzQVRzUjRma1daUFVPTlhJWHN2dmJSdnhZQmRjMGNOQnpsLHM9TGFEQS9IMXVvUG9SZUE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RHFheWZGc0FUc1I0ZmtXWlBVT05YSVhzdnZiUnZ4WUJkYzBjTkJ6bCxwPTUxRHhaYlJPME13MHl6cHlzRWR6T0dLZG0yL0dWUzZmME9jNWNDNyswMW89</response> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1LYVdkNmVrcWZGQWJUcHBzSWYvMGcwT3k1QzdSMW9vSmNuSU9uQmZMdTRjPQ==</success> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" ver="8SAx7sxxLI3422mjAeBbH2oWxJg=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost >> <iq xmlns="jabber:client" id="A3AaP5bMY2zxqYXk7GyeKKH" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost << <iq to="user_wk60nl0030@localhost/993927746-tigase-22" type="result" xmlns="jabber:client" id="A3AaP5bMY2zxqYXk7GyeKKH"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_wk60nl0030@localhost/993927746-tigase-22</jid></bind></iq> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="T5EtoN25ak0t3yfJutnLWiG" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost/993927746-tigase-22 << <iq to="user_wk60nl0030@localhost/993927746-tigase-22" type="result" xmlns="jabber:client" id="T5EtoN25ak0t3yfJutnLWiG"/> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="gRWgZq2cGCrkFMz8gSdxwbB" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost/993927746-tigase-22 << <enabled resume="true" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="ab8563e9-d15f-43e1-b9f6-9dbb016b53a8"/> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost/993927746-tigase-22 >> <iq id="hhaLY8o4oZqRalGm4Bj4hNC" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-20 19:45:55 | user :: user_wk60nl0030@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-20 19:45:55 | user :: user_wk60nl0030@localhost/993927746-tigase-22 << <iq to="user_wk60nl0030@localhost/993927746-tigase-22" type="result" xmlns="jabber:client" id="gRWgZq2cGCrkFMz8gSdxwbB" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost/993927746-tigase-22 << <iq to="user_wk60nl0030@localhost/993927746-tigase-22" type="result" xmlns="jabber:client" id="hhaLY8o4oZqRalGm4Bj4hNC"><query xmlns="jabber:iq:roster"/></iq> 2019-11-20 19:45:55 | Disconnecting 2019-11-20 19:45:55 | [Mutex] notify: [disconnected] 2019-11-20 19:45:55 | [Mutex] received everything. 2019-11-20 19:45:55 | [Mutex] waiting for: [event] 2019-11-20 19:45:55 | user :: user_wk60nl0030@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-20 19:45:55 | user :: user_wk60nl0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:55 | user :: user_wk60nl0030@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-20 19:45:55 | user :: user_wk60nl0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3drNjBubDAwMzAscj03cVdWM3FnTnNENEpMY25ZVHdyMA==</auth> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03cVdWM3FnTnNENEpMY25ZVHdyMHNrZll4V0lQZlhRSWdyOGpqOENHLHM9TGFEQS9IMXVvUG9SZUE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N3FXVjNxZ05zRDRKTGNuWVR3cjBza2ZZeFdJUGZYUUlncjhqajhDRyxwPXJxMVdJY2JxeDN5c29HdFMrbmZmWXFsbkQ3T2FwTTNzblZ6Q29HL0dIZkU9</response> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:55 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:55 | [Mutex] received everything. 2019-11-20 19:45:55 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:55 | [Mutex] waiting for: [event] 2019-11-20 19:45:55 | user :: user_wk60nl0030@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-20 19:45:55 | user :: user_wk60nl0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:55 | user :: user_wk60nl0030@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-20 19:45:55 | user :: user_wk60nl0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3drNjBubDAwMzAscj1YaWlaRW53QThJTmgwR0xWME5FSw==</auth> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YaWlaRW53QThJTmgwR0xWME5FS2NpajZpbXBFNUlUTEhmWEVlUEhQLHM9TGFEQS9IMXVvUG9SZUE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WGlpWkVud0E4SU5oMEdMVjBORUtjaWo2aW1wRTVJVExIZlhFZVBIUCxwPUFMV2d1UlpsSm5pWDFNdmMzb3VDSzdSTU1IcnRFSzRkWWtVTnFtaEFUMHM9</response> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:55 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:55 | [Mutex] received everything. 2019-11-20 19:45:55 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:55 | [Mutex] waiting for: [event] 2019-11-20 19:45:55 | user :: user_wk60nl0030@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-20 19:45:55 | user :: user_wk60nl0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:55 | user :: user_wk60nl0030@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-20 19:45:55 | user :: user_wk60nl0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3drNjBubDAwMzAscj1TNVdoU3RLc0FtcVZaQmJBaVNGUQ==</auth> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TNVdoU3RLc0FtcVZaQmJBaVNGUWJJRFJoYTZ4dE91Y0kwR1M1cWxXLHM9TGFEQS9IMXVvUG9SZUE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UzVXaFN0S3NBbXFWWkJiQWlTRlFiSURSaGE2eHRPdWNJMEdTNXFsVyxwPVUreXNieDcyelVpNm5LdXU3bFhqU2J0Y1AvTUtGL3lXNmgzbkx4M1MyME09</response> 2019-11-20 19:45:55 | user :: user_wk60nl0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure> 2019-11-20 19:45:55 | [Mutex] notify: [event, authFailed] 2019-11-20 19:45:55 | [Mutex] received everything. 2019-11-20 19:45:55 | [Mutex] isItemNotified: authFailed :: true 2019-11-20 19:45:56 | user :: user_wk60nl0030@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-20 19:45:56 | user :: user_wk60nl0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-20 19:45:56 | user :: user_wk60nl0030@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-20 19:45:56 | user :: user_wk60nl0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3drNjBubDAwMzAscj1UMVZiZlBITTZlalllZncwbEZvbQ==</auth> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UMVZiZlBITTZlalllZncwbEZvbUxpeFRHM2doR3B1b0FqYlkwTDdTLHM9TGFEQS9IMXVvUG9SZUE9PSxpPTQwOTY=</challenge> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VDFWYmZQSE02ZWpZZWZ3MGxGb21MaXhURzNnaEdwdW9BamJZMEw3UyxwPXI3cEkvcFdZY1B5S25mQjQvY2VUdmlUMDB3WGNLZWF1V0VLWUh2RGZGRzg9</response> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1UTzRUTGFkK2VLdWpISGw2V0NOaDNqYkxEYW03YXAvdGFkTHpDM2ZPYzVnPQ==</success> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" ver="8SAx7sxxLI3422mjAeBbH2oWxJg=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost >> <iq xmlns="jabber:client" id="1ZgW1hAFLxuoSfT8oN0toY4" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost << <iq to="user_wk60nl0030@localhost/993927746-tigase-23" type="result" xmlns="jabber:client" id="1ZgW1hAFLxuoSfT8oN0toY4"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_wk60nl0030@localhost/993927746-tigase-23</jid></bind></iq> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="Oml6oU6s7GncpOCADncxjEN" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost/993927746-tigase-23 << <iq to="user_wk60nl0030@localhost/993927746-tigase-23" type="result" xmlns="jabber:client" id="Oml6oU6s7GncpOCADncxjEN"/> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="naJDIrkFkEELDIznM3x5AAg" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost/993927746-tigase-23 << <enabled resume="true" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3" id="8b1e964e-b43c-4cef-833b-33556a931a1a"/> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost/993927746-tigase-23 >> <iq id="MW1qj4kMQW5CfWTMysnRatb" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-20 19:45:56 | user :: user_wk60nl0030@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-20 19:45:56 | user :: user_wk60nl0030@localhost/993927746-tigase-23 << <iq to="user_wk60nl0030@localhost/993927746-tigase-23" type="result" xmlns="jabber:client" id="naJDIrkFkEELDIznM3x5AAg" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10574/f55efd39" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:muted:0"/><feature var="tigase:push:priority:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost/993927746-tigase-23 << <iq to="user_wk60nl0030@localhost/993927746-tigase-23" type="result" xmlns="jabber:client" id="MW1qj4kMQW5CfWTMysnRatb"><query xmlns="jabber:iq:roster"/></iq> 2019-11-20 19:45:56 | Disconnecting 2019-11-20 19:45:56 | user :: user_wk60nl0030@localhost/993927746-tigase-23 << <presence to="user_wk60nl0030@localhost" xmlns="jabber:client" from="user_wk60nl0030@localhost/993927746-tigase-23"><c hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp"/></presence> 2019-11-20 19:45:56 | [Mutex] notify: [disconnected] 2019-11-20 19:45:56 | [Mutex] received everything. 2019-11-20 19:45:58 | [Mutex] waiting for: [user] 2019-11-20 19:45:58 | [Mutex] received everything. 2019-11-20 19:45:58 | [Mutex] isItemNotified: user:ok:true :: true |