Test duration: 13.387s
Passed Tests | ||
---|---|---|
tigase.tests.http.TestAdminUI | ||
testAddUser | 2.176s |
2020-06-01 23:04:28 |
2020-06-01 23:04:28 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-06-01 23:04:28 | ------------------------------------ |
testAuthorization | 0.165s |
2020-06-01 23:04:30 |
2020-06-01 23:04:30 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-06-01 23:04:30 | ------------------------------------ |
testCommandsAvailability | 0.732s |
2020-06-01 23:04:30 |
2020-06-01 23:04:30 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-06-01 23:04:30 | ------------------------------------ |
testDeleteUser | 1.133s |
2020-06-01 23:04:31 |
2020-06-01 23:04:31 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-06-01 23:04:31 | ------------------------------------ 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@27ee90a7 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Using XEP-0077 mode!!!! 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Connector state changed: null->connecting 2020-06-01 23:04:31 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@29297a2a}, 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@2d16fbd7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@68147011}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3bacbe1c}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:31 PDT 2020}}}} 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] DNS entry stored in session object: localhost:5222 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Preparing connection to [localhost:5222] 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Connector state changed: connecting->connected 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@59367b69 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Whitespace ping period is setted to nullms 2020-06-01 23:04:31 | [Mutex] waiting for: [registration] 2020-06-01 23:04:31 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@29297a2a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@2d16fbd7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@68147011}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3bacbe1c}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:31 PDT 2020}}}} 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@4364ebdb 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=3161] Start TLS 2020-06-01 23:04:31 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-06-01 23:04:31 | http-admin_ :: 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> 2020-06-01 23:04:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@83b8f5e} 2020-06-01 23:04:31 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-06-01 23:04:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=3163] Proceeding TLS 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=3163] Start handshake 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@56b99c1b 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3c3e4896 2020-06-01 23:04:31 | http-admin_ :: 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> 2020-06-01 23:04:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@586046f9} 2020-06-01 23:04:31 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-06-01 23:04:31 | http-admin_ :: null >> <iq to="localhost" id="DMFYmLwiNEAEACunQWZgXgD" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-06-01 23:04:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a1479049} 2020-06-01 23:04:31 | http-admin_ :: null << <iq type="result" id="DMFYmLwiNEAEACunQWZgXgD" from="localhost" xmlns="jabber:client"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service. Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x type="form" xmlns="jabber:x:data"><title>Account Registration</title><instructions>Choose a user name and password for use with this service. Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field type="hidden" var="FORM_TYPE"><value>jabber:iq:register</value></field><field label="Username" type="text-single" var="username"><required/><value/></field><field label="Password" type="text-private" var="password"><required/><value/></field><field label="Email (MUST BE VALID!)" type="text-single" var="email"><required/><value/></field></x></query></iq> 2020-06-01 23:04:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c7573d4} 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@16b66f05 2020-06-01 23:04:31 | http-admin_ :: null >> <iq to="localhost" id="mSVraLSRS7GRN3viZsX5k4b" type="set"><query xmlns="jabber:iq:register"><username>http-admin__juuygk0212</username><password>http-admin__juuygk0212</password><email>c91e19cb-a995-4089-b251-87ba9b12a5b1@localhost</email></query></iq> 2020-06-01 23:04:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@acccc289} 2020-06-01 23:04:31 | http-admin_ :: null << <iq type="result" id="mSVraLSRS7GRN3viZsX5k4b" from="localhost" xmlns="jabber:client"/> 2020-06-01 23:04:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5802ffbd} 2020-06-01 23:04:31 | [Mutex] received everything. 2020-06-01 23:04:31 | [Mutex] isItemNotified: registrationSuccess :: true 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Connector state changed: connected->disconnecting 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Terminating XMPP Stream 2020-06-01 23:04:31 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@83b8f5e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@586046f9]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@29297a2a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@2d16fbd7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@68147011}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3bacbe1c}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:31 PDT 2020}}}} 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=3163] Connector state changed: disconnecting->disconnected 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=3163] Stream terminated 2020-06-01 23:04:31 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@83b8f5e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@586046f9]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@29297a2a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@2d16fbd7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@68147011}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@3bacbe1c}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:31 PDT 2020}}}} 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@20f2dca 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2543158c 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@a88866 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:31 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4f1870d9 2020-06-01 23:04:31 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3402758d |
testGetUserInfoUserOffline | 4.262s |
2020-06-01 23:04:32 |
2020-06-01 23:04:32 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-06-01 23:04:32 | ------------------------------------ 2020-06-01 23:04:32 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Using XEP-0077 mode!!!! 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Connector state changed: null->connecting 2020-06-01 23:04:32 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@73ef17d5 2020-06-01 23:04:32 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7d28f7d8}, 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@79177ca5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3c15fde3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@37cf140b}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:32 PDT 2020}}}} 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] DNS entry stored in session object: localhost:5222 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Preparing connection to [localhost:5222] 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Connector state changed: connecting->connected 2020-06-01 23:04:32 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:32 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@d63a31d 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Whitespace ping period is setted to nullms 2020-06-01 23:04:32 | [Mutex] waiting for: [registration] 2020-06-01 23:04:32 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7d28f7d8}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@79177ca5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3c15fde3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@37cf140b}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:32 PDT 2020}}}} 2020-06-01 23:04:32 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@4f531440 2020-06-01 23:04:32 | http-admin_ :: 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> 2020-06-01 23:04:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5c3a02ac} 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=3169] Start TLS 2020-06-01 23:04:32 | 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>] 2020-06-01 23:04:32 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-06-01 23:04:32 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=3171] Proceeding TLS 2020-06-01 23:04:32 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=3171] Start handshake 2020-06-01 23:04:32 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:32 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@139a3a6c 2020-06-01 23:04:33 | http-admin_ :: 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> 2020-06-01 23:04:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3710849} 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5457fd73 2020-06-01 23:04:33 | 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>] 2020-06-01 23:04:33 | http-admin_ :: null >> <iq to="localhost" id="42nIt7ocrS0dug0i2k3cEp6" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-06-01 23:04:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@647c1b76} 2020-06-01 23:04:33 | http-admin_ :: null << <iq type="result" id="42nIt7ocrS0dug0i2k3cEp6" from="localhost" xmlns="jabber:client"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service. Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x type="form" xmlns="jabber:x:data"><title>Account Registration</title><instructions>Choose a user name and password for use with this service. Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field type="hidden" var="FORM_TYPE"><value>jabber:iq:register</value></field><field label="Username" type="text-single" var="username"><required/><value/></field><field label="Password" type="text-private" var="password"><required/><value/></field><field label="Email (MUST BE VALID!)" type="text-single" var="email"><required/><value/></field></x></query></iq> 2020-06-01 23:04:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5874ba37} 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1affa20f 2020-06-01 23:04:33 | http-admin_ :: null >> <iq to="localhost" id="SUXvi1oTWfWnP7Dyvu1dAAd" type="set"><query xmlns="jabber:iq:register"><username>http-admin__939odv0213</username><password>http-admin__939odv0213</password><email>93be8510-6138-4507-a7ce-789ac16a0f32@localhost</email></query></iq> 2020-06-01 23:04:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d0ff296f} 2020-06-01 23:04:33 | http-admin_ :: null << <iq type="result" id="SUXvi1oTWfWnP7Dyvu1dAAd" from="localhost" xmlns="jabber:client"/> 2020-06-01 23:04:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@11c7c259} 2020-06-01 23:04:33 | [Mutex] received everything. 2020-06-01 23:04:33 | [Mutex] isItemNotified: registrationSuccess :: true 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Connector state changed: connected->disconnecting 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Terminating XMPP Stream 2020-06-01 23:04:33 | 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;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5c3a02ac, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3710849]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7d28f7d8}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@79177ca5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3c15fde3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@37cf140b}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:33 PDT 2020}}}} 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=3171] Connector state changed: disconnecting->disconnected 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=3171] Stream terminated 2020-06-01 23:04:33 | 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;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5c3a02ac, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3710849]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@7d28f7d8}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@79177ca5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@3c15fde3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@37cf140b}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:33 PDT 2020}}}} 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7a900977 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7c8a110 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6040843c 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4f3a4767 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@351b2446 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Connector state changed: null->connecting 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] DNS entry stored in session object: localhost:5222 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Preparing connection to [localhost:5222] 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Connector state changed: connecting->connected 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Whitespace ping period is setted to nullms 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@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> 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=3176] Start TLS 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=3178] Proceeding TLS 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=3178] Start handshake 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@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> 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX185MzlvZHYwMjEzLHI9aVVIWVJyN1pHdVBzYXZmbnc4Z0s=</auth> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pVUhZUnI3Wkd1UHNhdmZudzhnSzhHVzVUSlFXS2FZT1JWa1oyamJMLHM9MzRSbG95VEpFRnRLeWc9PSxpPTQwOTY=</challenge> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aVVIWVJyN1pHdVBzYXZmbnc4Z0s4R1c1VEpRV0thWU9SVmtaMmpiTCxwPTFBSWtOb3VTZndUb1dvWTB5Y0lrOTlXNDdZY2hTUFNhOEZWMGZZY0NSb009</response> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj10b0R5QkZPTjZaNnBYRXZUZ1dyQVE1dFlvOGRleW1zWE95VGc5ci9vWnVzPQ==</success> 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@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 ver="AD4uCFRGHwjXvLmXoK7swQZnVag=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost >> <iq xmlns="jabber:client" id="O7yQ5gMFCFGt6zAFphXcN4b" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost << <iq type="result" id="O7yQ5gMFCFGt6zAFphXcN4b" to="http-admin__939odv0213@localhost/2095755800-tigase-232" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__939odv0213@localhost/2095755800-tigase-232</jid></bind></iq> 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost/2095755800-tigase-232 >> <iq xmlns="jabber:client" id="CJmnUev0gJwk8yym7kUV8HK" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost/2095755800-tigase-232 << <iq type="result" id="CJmnUev0gJwk8yym7kUV8HK" to="http-admin__939odv0213@localhost/2095755800-tigase-232" xmlns="jabber:client"/> 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost/2095755800-tigase-232 >> <iq to="localhost" id="oZ67AhIN2zdTbEHSNLGMBcE" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost/2095755800-tigase-232 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost/2095755800-tigase-232 << <enabled id="e9629156-fea1-4352-bde5-e640f04cbe9a" resume="true" max="60" xmlns="urn:xmpp:sm:3" location="9585556aacac"/> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost/2095755800-tigase-232 >> <iq id="SY1DyxqX4vspTfT4xy9t6Ch" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost/2095755800-tigase-232 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost/2095755800-tigase-232 << <iq type="result" id="oZ67AhIN2zdTbEHSNLGMBcE" from="localhost" to="http-admin__939odv0213@localhost/2095755800-tigase-232" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10747/15d7a283" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10747/15d7a283" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost/2095755800-tigase-232 << <iq type="result" id="SY1DyxqX4vspTfT4xy9t6Ch" to="http-admin__939odv0213@localhost/2095755800-tigase-232" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Connector state changed: connected->disconnecting 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Terminating XMPP Stream 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=3178] Connector state changed: disconnecting->disconnected 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=3178] Stream terminated 2020-06-01 23:04:33 | http-admin_ :: http-admin__939odv0213@localhost/2095755800-tigase-232 << <presence to="http-admin__939odv0213@localhost" from="http-admin__939odv0213@localhost/2095755800-tigase-232" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence> 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Using XEP-0077 mode!!!! 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Connector state changed: null->connecting 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2208ed18 2020-06-01 23:04:33 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2ccf1729}, 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@28f08668}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6df21d12}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@8f74d99}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:33 PDT 2020}}}} 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] DNS entry stored in session object: localhost:5222 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Preparing connection to [localhost:5222] 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Connector state changed: connecting->connected 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Whitespace ping period is setted to nullms 2020-06-01 23:04:33 | [Mutex] waiting for: [registration] 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5c5575f1 2020-06-01 23:04:33 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2ccf1729}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@28f08668}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6df21d12}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@8f74d99}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:33 PDT 2020}}}} 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@70ba7bd5 2020-06-01 23:04:33 | http-admin_ :: 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> 2020-06-01 23:04:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@ddde25d} 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=3183] Start TLS 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=3185] Proceeding TLS 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=3185] Start handshake 2020-06-01 23:04:33 | 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>] 2020-06-01 23:04:33 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-06-01 23:04:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3f74fdfa 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4879fd18 2020-06-01 23:04:33 | http-admin_ :: 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> 2020-06-01 23:04:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6bbe5311} 2020-06-01 23:04:33 | 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>] 2020-06-01 23:04:33 | http-admin_ :: null >> <iq to="localhost" id="ETKoPEyjGEMQ8wrYcvi1oTW" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-06-01 23:04:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6ff0f9d2} 2020-06-01 23:04:33 | http-admin_ :: null << <iq type="result" id="ETKoPEyjGEMQ8wrYcvi1oTW" from="localhost" xmlns="jabber:client"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service. Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x type="form" xmlns="jabber:x:data"><title>Account Registration</title><instructions>Choose a user name and password for use with this service. Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field type="hidden" var="FORM_TYPE"><value>jabber:iq:register</value></field><field label="Username" type="text-single" var="username"><required/><value/></field><field label="Password" type="text-private" var="password"><required/><value/></field><field label="Email (MUST BE VALID!)" type="text-single" var="email"><required/><value/></field></x></query></iq> 2020-06-01 23:04:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@9939b31} 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@11903cd4 2020-06-01 23:04:33 | http-admin_ :: null >> <iq to="localhost" id="MeJeU4xaAhQ7AhIN2zdTbEH" type="set"><query xmlns="jabber:iq:register"><username>http-admin__9tyxm70214</username><password>http-admin__9tyxm70214</password><email>b489b883-54f7-413d-98a5-9a2053b14e7c@localhost</email></query></iq> 2020-06-01 23:04:33 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f0ab99da} 2020-06-01 23:04:33 | http-admin_ :: null << <iq type="result" id="MeJeU4xaAhQ7AhIN2zdTbEH" from="localhost" xmlns="jabber:client"/> 2020-06-01 23:04:33 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@160692c3} 2020-06-01 23:04:33 | [Mutex] received everything. 2020-06-01 23:04:33 | [Mutex] isItemNotified: registrationSuccess :: true 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Connector state changed: connected->disconnecting 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Terminating XMPP Stream 2020-06-01 23:04:33 | 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;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@ddde25d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6bbe5311]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2ccf1729}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@28f08668}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6df21d12}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@8f74d99}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:33 PDT 2020}}}} 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=3185] Connector state changed: disconnecting->disconnected 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=3185] Stream terminated 2020-06-01 23:04:33 | 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;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@ddde25d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6bbe5311]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2ccf1729}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@28f08668}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6df21d12}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@8f74d99}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:33 PDT 2020}}}} 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@fb96dc9 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1ae6251c 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@a00dc08 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Connector state changed: null->connecting 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@28b2c701 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@6c2130fb 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] DNS entry stored in session object: localhost:5222 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Preparing connection to [localhost:5222] 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Connector state changed: connecting->connected 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Whitespace ping period is setted to nullms 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@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> 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=3190] Start TLS 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=3192] Proceeding TLS 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=3192] Start handshake 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@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> 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX185dHl4bTcwMjE0LHI9ZlMzZkdzRnRrYlVrNnFrUDc2UGs=</auth> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mUzNmR3NGdGtiVWs2cWtQNzZQa3RweUEzVEdJQWIxNktUZjBncDh2LHM9UFgxaHFtNjFBVE80c0E9PSxpPTQwOTY=</challenge> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZlMzZkdzRnRrYlVrNnFrUDc2UGt0cHlBM1RHSUFiMTZLVGYwZ3A4dixwPVRMV3FkWUJzNW9BZ3RiYnNHY2ZuakJOOVlIaW9NdFh6cmVhRWF2ZFQzSG89</response> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1jRWZmNmlva1ZRNFB1dmxyVUtrVElUTmN0My8xL2RrZEp0Ym9yUy9wYjR3PQ==</success> 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@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 ver="AD4uCFRGHwjXvLmXoK7swQZnVag=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost >> <iq xmlns="jabber:client" id="0Qx1raJWV1cOFkU16uscQWh" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost << <iq type="result" id="0Qx1raJWV1cOFkU16uscQWh" to="http-admin__9tyxm70214@localhost/2095755800-tigase-233" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__9tyxm70214@localhost/2095755800-tigase-233</jid></bind></iq> 2020-06-01 23:04:33 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 >> <iq xmlns="jabber:client" id="ueFjHR7wrmLHyw5aAnOUiSc" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 << <iq type="result" id="ueFjHR7wrmLHyw5aAnOUiSc" to="http-admin__9tyxm70214@localhost/2095755800-tigase-233" xmlns="jabber:client"/> 2020-06-01 23:04:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 >> <iq to="localhost" id="VeD6jMVi5fXjUdURTWiDgML" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 >> <iq id="OgH8Fq6jUfQNKRaPJVfMXoP" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 << <enabled id="715e9942-ce09-4425-9761-ab44b346626f" resume="true" max="60" xmlns="urn:xmpp:sm:3" location="9585556aacac"/> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 << <iq type="result" id="VeD6jMVi5fXjUdURTWiDgML" from="localhost" to="http-admin__9tyxm70214@localhost/2095755800-tigase-233" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10747/15d7a283" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10747/15d7a283" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 << <iq type="result" id="OgH8Fq6jUfQNKRaPJVfMXoP" to="http-admin__9tyxm70214@localhost/2095755800-tigase-233" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 >> <message to="http-admin__939odv0213@localhost" id="ihIaJymPWjY3gTeXZrhQ5El"><body>Test message 1</body></message> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 << <presence to="http-admin__9tyxm70214@localhost" from="http-admin__9tyxm70214@localhost/2095755800-tigase-233" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence> 2020-06-01 23:04:33 | http-admin_ :: http-admin__9tyxm70214@localhost/2095755800-tigase-233 >> <message to="http-admin__939odv0213@localhost" id="BkPbxeSNAq3aCIIS0pU4fMZ"><body>Test message 2</body></message> 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=3192] Connector state changed: connected->disconnected 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=3192] Stream terminated 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
testGetUserInfoUserOnline | 1.249s |
2020-06-01 23:04:37 |
2020-06-01 23:04:37 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-06-01 23:04:37 | ------------------------------------ 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Using XEP-0077 mode!!!! 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Connector state changed: null->connecting 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@18827b31 2020-06-01 23:04:37 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@16458651}, 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@127a1041}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@57788c6a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c283e47}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:37 PDT 2020}}}} 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] DNS entry stored in session object: localhost:5222 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Preparing connection to [localhost:5222] 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Connector state changed: connecting->connected 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Whitespace ping period is setted to nullms 2020-06-01 23:04:37 | [Mutex] waiting for: [registration] 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@66e55c9d 2020-06-01 23:04:37 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@16458651}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@127a1041}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@57788c6a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c283e47}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:37 PDT 2020}}}} 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@245fb018 2020-06-01 23:04:37 | http-admin_ :: 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> 2020-06-01 23:04:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@37577325} 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=3197] Start TLS 2020-06-01 23:04:37 | 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>] 2020-06-01 23:04:37 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-06-01 23:04:37 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=3199] Proceeding TLS 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=3199] Start handshake 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2a10a98e 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@665d09e5 2020-06-01 23:04:37 | http-admin_ :: 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> 2020-06-01 23:04:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3f5bba46} 2020-06-01 23:04:37 | 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>] 2020-06-01 23:04:37 | http-admin_ :: null >> <iq to="localhost" id="tgx0v5DFCDKxfEItW8t0i4q" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-06-01 23:04:37 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4fffafe3} 2020-06-01 23:04:37 | http-admin_ :: null << <iq type="result" id="tgx0v5DFCDKxfEItW8t0i4q" from="localhost" xmlns="jabber:client"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service. Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x type="form" xmlns="jabber:x:data"><title>Account Registration</title><instructions>Choose a user name and password for use with this service. Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field type="hidden" var="FORM_TYPE"><value>jabber:iq:register</value></field><field label="Username" type="text-single" var="username"><required/><value/></field><field label="Password" type="text-private" var="password"><required/><value/></field><field label="Email (MUST BE VALID!)" type="text-single" var="email"><required/><value/></field></x></query></iq> 2020-06-01 23:04:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@331928d3} 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1c6abbe7 2020-06-01 23:04:37 | http-admin_ :: null >> <iq to="localhost" id="PadjIGteT8nUbO7j5zqfYZ9" type="set"><query xmlns="jabber:iq:register"><username>http-admin__ksbymg0215</username><password>http-admin__ksbymg0215</password><email>cea1678d-a285-4f46-a291-3a97ec4b94fc@localhost</email></query></iq> 2020-06-01 23:04:37 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@9baa9c79} 2020-06-01 23:04:37 | http-admin_ :: null << <iq type="result" id="PadjIGteT8nUbO7j5zqfYZ9" from="localhost" xmlns="jabber:client"/> 2020-06-01 23:04:37 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@12769bae} 2020-06-01 23:04:37 | [Mutex] received everything. 2020-06-01 23:04:37 | [Mutex] isItemNotified: registrationSuccess :: true 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Connector state changed: connected->disconnecting 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Terminating XMPP Stream 2020-06-01 23:04:37 | 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;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@37577325, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3f5bba46]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@16458651}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@127a1041}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@57788c6a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c283e47}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:37 PDT 2020}}}} 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=3199] Connector state changed: disconnecting->disconnected 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=3199] Stream terminated 2020-06-01 23:04:37 | 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;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@37577325, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3f5bba46]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@16458651}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@127a1041}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@57788c6a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5c283e47}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:37 PDT 2020}}}} 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@701d8a2c 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@a386b4c 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@43445c6f 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@65c90442 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7919be3d 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] Connector state changed: null->connecting 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] DNS entry stored in session object: localhost:5222 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] Preparing connection to [localhost:5222] 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] Connector state changed: connecting->connected 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] Whitespace ping period is setted to nullms 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@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> 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3204] Start TLS 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3206] Proceeding TLS 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3206] Start handshake 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@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> 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19rc2J5bWcwMjE1LHI9TGV2OWo4RU8yTVY2QTUwRzBoNk8=</auth> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MZXY5ajhFTzJNVjZBNTBHMGg2T3NpU09HYm10c1RyeWNBSDNjRGN3LHM9Q1FITytBa0xwZzJLcHc9PSxpPTQwOTY=</challenge> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TGV2OWo4RU8yTVY2QTUwRzBoNk9zaVNPR2JtdHNUcnljQUgzY0RjdyxwPXI0Z3BFbUpwTkpZZmVRVkxOZlhnQVBzSk10NStrRFV0azRqN0xBbVJOQlE9</response> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1relJpNEdlckJITW1JanpVaVBNTmxKOTFCNytia0J6cGxOenM4RmRoSkR3PQ==</success> 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@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 ver="AD4uCFRGHwjXvLmXoK7swQZnVag=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost >> <iq xmlns="jabber:client" id="CYBRSanKKHscS2wiZ4oT4zu" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost << <iq type="result" id="CYBRSanKKHscS2wiZ4oT4zu" to="http-admin__ksbymg0215@localhost/2095755800-tigase-234" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__ksbymg0215@localhost/2095755800-tigase-234</jid></bind></iq> 2020-06-01 23:04:37 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost/2095755800-tigase-234 >> <iq xmlns="jabber:client" id="Scf5sl2bwpg17HNS9MBnUev" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost/2095755800-tigase-234 << <iq type="result" id="Scf5sl2bwpg17HNS9MBnUev" to="http-admin__ksbymg0215@localhost/2095755800-tigase-234" xmlns="jabber:client"/> 2020-06-01 23:04:37 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost/2095755800-tigase-234 >> <iq to="localhost" id="FnK12kRMQaCGCDmY3odMFul" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost/2095755800-tigase-234 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost/2095755800-tigase-234 << <enabled id="8df2a9ff-0bd2-4f22-bbc9-a723a0a6bf7a" resume="true" max="60" xmlns="urn:xmpp:sm:3" location="9585556aacac"/> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost/2095755800-tigase-234 >> <iq id="K2HaOUgMX0gDyxqX4vspTfT" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost/2095755800-tigase-234 << <iq type="result" id="FnK12kRMQaCGCDmY3odMFul" from="localhost" to="http-admin__ksbymg0215@localhost/2095755800-tigase-234" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10747/15d7a283" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10747/15d7a283" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost/2095755800-tigase-234 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost/2095755800-tigase-234 << <iq type="result" id="K2HaOUgMX0gDyxqX4vspTfT" to="http-admin__ksbymg0215@localhost/2095755800-tigase-234" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2020-06-01 23:04:37 | http-admin_ :: http-admin__ksbymg0215@localhost/2095755800-tigase-234 << <presence to="http-admin__ksbymg0215@localhost" from="http-admin__ksbymg0215@localhost/2095755800-tigase-234" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence> |
testModifyUser | 2.322s |
2020-06-01 23:04:38 |
2020-06-01 23:04:38 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-06-01 23:04:38 | ------------------------------------ 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=1] Using XEP-0077 mode!!!! 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@23c6873c 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=1] Connector state changed: null->connecting 2020-06-01 23:04:38 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2d017d34}, 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@293eec4c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6c3c770f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bd4f2d3}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:38 PDT 2020}}}} 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=1] DNS entry stored in session object: localhost:5222 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=1] Preparing connection to [localhost:5222] 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=1] Connector state changed: connecting->connected 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=1] Whitespace ping period is setted to nullms 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5d9ad840 2020-06-01 23:04:38 | [Mutex] waiting for: [registration] 2020-06-01 23:04:38 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2d017d34}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@293eec4c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6c3c770f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bd4f2d3}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:38 PDT 2020}}}} 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@3980333 2020-06-01 23:04:38 | http-admin_ :: 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> 2020-06-01 23:04:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c138840} 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=3210] Start TLS 2020-06-01 23:04:38 | 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>] 2020-06-01 23:04:38 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-06-01 23:04:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=3212] Proceeding TLS 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=3212] Start handshake 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@500da17b 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5bde2be2 2020-06-01 23:04:38 | http-admin_ :: 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> 2020-06-01 23:04:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@189c2a31} 2020-06-01 23:04:38 | 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>] 2020-06-01 23:04:38 | http-admin_ :: null >> <iq to="localhost" id="vu1BFJKTgzjMYZYcBgO6uq6" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-06-01 23:04:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d8c47f18} 2020-06-01 23:04:38 | http-admin_ :: null << <iq type="result" id="vu1BFJKTgzjMYZYcBgO6uq6" from="localhost" xmlns="jabber:client"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service. Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x type="form" xmlns="jabber:x:data"><title>Account Registration</title><instructions>Choose a user name and password for use with this service. Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field type="hidden" var="FORM_TYPE"><value>jabber:iq:register</value></field><field label="Username" type="text-single" var="username"><required/><value/></field><field label="Password" type="text-private" var="password"><required/><value/></field><field label="Email (MUST BE VALID!)" type="text-single" var="email"><required/><value/></field></x></query></iq> 2020-06-01 23:04:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@85df0ea} 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@35669ee3 2020-06-01 23:04:38 | http-admin_ :: null >> <iq to="localhost" id="l6PoT4zu5k1ut1vp6BGpZ8G" type="set"><query xmlns="jabber:iq:register"><username>http-admin__bmsh4m0216</username><password>http-admin__bmsh4m0216</password><email>243910a2-06ca-4564-9cd8-2833feb0dbde@localhost</email></query></iq> 2020-06-01 23:04:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b959564c} 2020-06-01 23:04:38 | http-admin_ :: null << <iq type="result" id="l6PoT4zu5k1ut1vp6BGpZ8G" from="localhost" xmlns="jabber:client"/> 2020-06-01 23:04:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1fcd3296} 2020-06-01 23:04:38 | [Mutex] received everything. 2020-06-01 23:04:38 | [Mutex] isItemNotified: registrationSuccess :: true 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=1] Connector state changed: connected->disconnecting 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=1] Terminating XMPP Stream 2020-06-01 23:04:38 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c138840, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@189c2a31]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2d017d34}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@293eec4c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6c3c770f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bd4f2d3}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:38 PDT 2020}}}} 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=3212] Connector state changed: disconnecting->disconnected 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=508 thread=3212] Stream terminated 2020-06-01 23:04:38 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2d6ab518}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c138840, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@189c2a31]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2d017d34}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@1f89902f}, 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@293eec4c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6c3c770f}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7bd4f2d3}, 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=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Jun 01 23:04:38 PDT 2020}}}} 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@66f94efc 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1443869 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@542f24 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@76fbe43a 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5ad9cab7 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=1] Connector state changed: null->connecting 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=1] DNS entry stored in session object: localhost:5222 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=1] Preparing connection to [localhost:5222] 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=1] Connector state changed: connecting->connected 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=1] Whitespace ping period is setted to nullms 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@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> 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=3217] Start TLS 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=3219] Proceeding TLS 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=3219] Start handshake 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@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> 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19ibXNoNG0wMjE2LHI9UHhjdGo4WWh3UzE5Z1NVTGwxbjY=</auth> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QeGN0ajhZaHdTMTlnU1VMbDFuNkd1dnljNUFIVkR4VVdhQk5QQUxSLHM9RmovOXFWbjd3bUxLOVE9PSxpPTQwOTY=</challenge> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UHhjdGo4WWh3UzE5Z1NVTGwxbjZHdXZ5YzVBSFZEeFVXYUJOUEFMUixwPXhiZU04UnR4QkhhdU5NNEkyQlJORGgwZkhYZEdRa3RhVjJhVjBORWNTZ0E9</response> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1KeFN5RTdVLzNIS2hFS2FQOCtHK2dSWnJiT2lKc09aSGxtUnQzd1g0UE5FPQ==</success> 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@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 ver="AD4uCFRGHwjXvLmXoK7swQZnVag=" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost >> <iq xmlns="jabber:client" id="PhlycEp6DClQ3yBh1raJWV1" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost << <iq type="result" id="PhlycEp6DClQ3yBh1raJWV1" to="http-admin__bmsh4m0216@localhost/2095755800-tigase-235" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__bmsh4m0216@localhost/2095755800-tigase-235</jid></bind></iq> 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost/2095755800-tigase-235 >> <iq xmlns="jabber:client" id="SimiSbIxeP6HtpdIP8jNKUR" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost/2095755800-tigase-235 << <iq type="result" id="SimiSbIxeP6HtpdIP8jNKUR" to="http-admin__bmsh4m0216@localhost/2095755800-tigase-235" xmlns="jabber:client"/> 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost/2095755800-tigase-235 >> <iq to="localhost" id="uvXSP7Dyvu1dAAdq6pS2yoe" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost/2095755800-tigase-235 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost/2095755800-tigase-235 << <enabled id="6c49485c-4c48-4b58-b1c6-fe2c9e3be33a" resume="true" max="60" xmlns="urn:xmpp:sm:3" location="9585556aacac"/> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost/2095755800-tigase-235 >> <iq id="ytPpdURTWiDgMLAso4AqfAq" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost/2095755800-tigase-235 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost/2095755800-tigase-235 << <iq type="result" id="uvXSP7Dyvu1dAAdq6pS2yoe" from="localhost" to="http-admin__bmsh4m0216@localhost/2095755800-tigase-235" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10747/15d7a283" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10747/15d7a283" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost/2095755800-tigase-235 << <iq type="result" id="ytPpdURTWiDgMLAso4AqfAq" to="http-admin__bmsh4m0216@localhost/2095755800-tigase-235" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=1] Connector state changed: connected->disconnecting 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=1] Terminating XMPP Stream 2020-06-01 23:04:38 | http-admin_ :: http-admin__bmsh4m0216@localhost/2095755800-tigase-235 << <presence to="http-admin__bmsh4m0216@localhost" from="http-admin__bmsh4m0216@localhost/2095755800-tigase-235" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence> 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=509 thread=3219] Connector state changed: disconnecting->disconnected 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-06-01 23:04:38 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-06-01 23:04:40 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=1] Connector state changed: null->connecting 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=1] DNS entry stored in session object: localhost:5222 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=1] Preparing connection to [localhost:5222] 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=1] Connector state changed: connecting->connected 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=1] Whitespace ping period is setted to nullms 2020-06-01 23:04:40 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:40 | http-admin_ :: http-admin__bmsh4m0216@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> 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=3217] Start TLS 2020-06-01 23:04:40 | http-admin_ :: http-admin__bmsh4m0216@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=3225] Proceeding TLS 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=3225] Start handshake 2020-06-01 23:04:40 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-06-01 23:04:40 | http-admin_ :: http-admin__bmsh4m0216@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> 2020-06-01 23:04:40 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-06-01 23:04:40 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-06-01 23:04:40 | http-admin_ :: http-admin__bmsh4m0216@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19ibXNoNG0wMjE2LHI9Y0NydmFMYkZoT3ZEcDkyVDNDNDM=</auth> 2020-06-01 23:04:40 | http-admin_ :: http-admin__bmsh4m0216@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jQ3J2YUxiRmhPdkRwOTJUM0M0M0tLZDNlWU0xMXpRcG5pV2JiS3NELHM9RmovOXFWbjd3bUxLOVE9PSxpPTQwOTY=</challenge> 2020-06-01 23:04:40 | http-admin_ :: http-admin__bmsh4m0216@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y0NydmFMYkZoT3ZEcDkyVDNDNDNLS2QzZVlNMTF6UXBuaVdiYktzRCxwPVdqK0tHMjJzNk5GRGVrWm11Ymw1ZUdFOWdqaHRON2VuV0R6ejRBazYxSjQ9</response> 2020-06-01 23:04:40 | http-admin_ :: http-admin__bmsh4m0216@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: http-admin__bmsh4m0216@localhost is not authorized to act as http-admin__bmsh4m0216@localhost</text></failure> 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=3217] Connector state changed: connected->disconnecting 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=3217] Terminating XMPP Stream 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=3225] Connector state changed: disconnecting->disconnected 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=3225] Stream terminated 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:40 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-06-01 23:04:40 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.Jaxmpp.onException: Catching exception 2020-06-01 23:04:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=510 thread=3217] Ignoring stop connector. |