Test duration: 13.518s
Passed Tests | ||
---|---|---|
tigase.tests.http.TestAdminUI | ||
testAddUser | 2.084s |
2020-05-27 00:58:37 |
2020-05-27 00:58:37 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-05-27 00:58:37 | ------------------------------------ |
testAuthorization | 0.190s |
2020-05-27 00:58:39 |
2020-05-27 00:58:39 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-05-27 00:58:39 | ------------------------------------ |
testCommandsAvailability | 1.012s |
2020-05-27 00:58:39 |
2020-05-27 00:58:39 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-05-27 00:58:39 | ------------------------------------ |
testDeleteUser | 1.062s |
2020-05-27 00:58:40 |
2020-05-27 00:58:40 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-05-27 00:58:40 | ------------------------------------ 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@552a2925 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=1] Using XEP-0077 mode!!!! 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=1] Connector state changed: null->connecting 2020-05-27 00:58:40 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5bedcdf0}, 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@5fd24255}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1ad0c7cb}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1e37a6b5}, 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=Wed May 27 00:58:40 PDT 2020}}}} 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=1] DNS entry stored in session object: localhost:5222 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=1] Preparing connection to [localhost:5222] 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=1] Connector state changed: connecting->connected 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=1] Whitespace ping period is setted to nullms 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2b807ace 2020-05-27 00:58:40 | [Mutex] waiting for: [registration] 2020-05-27 00:58:40 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5bedcdf0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@5fd24255}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1ad0c7cb}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1e37a6b5}, 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=Wed May 27 00:58:40 PDT 2020}}}} 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@668d4501 2020-05-27 00:58:40 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:40 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7aff3884} 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=3144] Start TLS 2020-05-27 00:58:40 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-05-27 00:58:40 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-27 00:58:40 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=3146] Proceeding TLS 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=3146] Start handshake 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@59de2b60 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@71206c9f 2020-05-27 00:58:40 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:40 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7d898af7} 2020-05-27 00:58:40 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-05-27 00:58:40 | http-admin_ :: null >> <iq to="localhost" id="TxqCtl18mWkGqkP7i5EHMBz" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-05-27 00:58:40 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@66200e6e} 2020-05-27 00:58:40 | http-admin_ :: null << <iq xmlns="jabber:client" id="TxqCtl18mWkGqkP7i5EHMBz" from="localhost" type="result"><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 xmlns="jabber:x:data" type="form"><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 var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field var="username" label="Username" type="text-single"><required/><value/></field><field var="password" label="Password" type="text-private"><required/><value/></field><field var="email" label="Email (MUST BE VALID!)" type="text-single"><required/><value/></field></x></query></iq> 2020-05-27 00:58:40 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7eb1a6da} 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@561c0747 2020-05-27 00:58:40 | http-admin_ :: null >> <iq to="localhost" id="Mxoi5zugSV8vp9oSYoOGQRb" type="set"><query xmlns="jabber:iq:register"><username>http-admin__9c5z820208</username><password>http-admin__9c5z820208</password><email>a8d2b7b2-311d-4761-a2e2-f18bfc85b894@localhost</email></query></iq> 2020-05-27 00:58:40 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@eb0b8ad0} 2020-05-27 00:58:40 | http-admin_ :: null << <iq xmlns="jabber:client" id="Mxoi5zugSV8vp9oSYoOGQRb" from="localhost" type="result"/> 2020-05-27 00:58:40 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@242add8f} 2020-05-27 00:58:40 | [Mutex] received everything. 2020-05-27 00:58:40 | [Mutex] isItemNotified: registrationSuccess :: true 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=1] Connector state changed: connected->disconnecting 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=1] Terminating XMPP Stream 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=3146] Connector state changed: disconnecting->disconnected 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=498 thread=3146] Stream terminated 2020-05-27 00:58:40 | 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;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7aff3884, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7d898af7]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5bedcdf0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@5fd24255}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1ad0c7cb}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1e37a6b5}, 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=Wed May 27 00:58:40 PDT 2020}}}} 2020-05-27 00:58:40 | 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;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7aff3884, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7d898af7]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5bedcdf0}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@5fd24255}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1ad0c7cb}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1e37a6b5}, 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=Wed May 27 00:58:40 PDT 2020}}}} 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@15c535cf 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@66b1c6db 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5021c375 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:40 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2295aa5b 2020-05-27 00:58:40 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1ec2888b |
testGetUserInfoUserOffline | 4.117s |
2020-05-27 00:58:41 |
2020-05-27 00:58:41 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-05-27 00:58:41 | ------------------------------------ 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=1] Using XEP-0077 mode!!!! 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=1] Connector state changed: null->connecting 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@27d9c8c5 2020-05-27 00:58:41 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@291e224e}, 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@2d21a3b5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@68232875}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1d55a54}, 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=Wed May 27 00:58:41 PDT 2020}}}} 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=1] DNS entry stored in session object: localhost:5222 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=1] Preparing connection to [localhost:5222] 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=1] Connector state changed: connecting->connected 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=1] Whitespace ping period is setted to nullms 2020-05-27 00:58:41 | [Mutex] waiting for: [registration] 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@59010472 2020-05-27 00:58:41 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@291e224e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@2d21a3b5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@68232875}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1d55a54}, 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=Wed May 27 00:58:41 PDT 2020}}}} 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@791d28ec 2020-05-27 00:58:41 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@80cd73a} 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=3152] Start TLS 2020-05-27 00:58:41 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-05-27 00:58:41 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-27 00:58:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=3154] Proceeding TLS 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=3154] Start handshake 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@23a03b95 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@72538907 2020-05-27 00:58:41 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@621985e9} 2020-05-27 00:58:41 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-05-27 00:58:41 | http-admin_ :: null >> <iq to="localhost" id="OTqJOUaviP3rY2i26g0bPIV" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-05-27 00:58:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1486190f} 2020-05-27 00:58:41 | http-admin_ :: null << <iq xmlns="jabber:client" id="OTqJOUaviP3rY2i26g0bPIV" from="localhost" type="result"><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 xmlns="jabber:x:data" type="form"><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 var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field var="username" label="Username" type="text-single"><required/><value/></field><field var="password" label="Password" type="text-private"><required/><value/></field><field var="email" label="Email (MUST BE VALID!)" type="text-single"><required/><value/></field></x></query></iq> 2020-05-27 00:58:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c422b97} 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@2e1cc519 2020-05-27 00:58:41 | http-admin_ :: null >> <iq to="localhost" id="gzqmdP0iW3o1rdw8uqSO6nd" type="set"><query xmlns="jabber:iq:register"><username>http-admin__q92iq0209</username><password>http-admin__q92iq0209</password><email>da222758-d542-4945-b42d-79f91fc24322@localhost</email></query></iq> 2020-05-27 00:58:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@cf0b8665} 2020-05-27 00:58:41 | http-admin_ :: null << <iq xmlns="jabber:client" id="gzqmdP0iW3o1rdw8uqSO6nd" from="localhost" type="result"/> 2020-05-27 00:58:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@40696a6c} 2020-05-27 00:58:41 | [Mutex] received everything. 2020-05-27 00:58:41 | [Mutex] isItemNotified: registrationSuccess :: true 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=1] Connector state changed: connected->disconnecting 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=1] Terminating XMPP Stream 2020-05-27 00:58:41 | 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;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@80cd73a, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@621985e9]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@291e224e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@2d21a3b5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@68232875}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1d55a54}, 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=Wed May 27 00:58:41 PDT 2020}}}} 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=3154] Connector state changed: disconnecting->disconnected 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=499 thread=3154] Stream terminated 2020-05-27 00:58:41 | 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;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@80cd73a, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@621985e9]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@291e224e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@2d21a3b5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@68232875}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1d55a54}, 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=Wed May 27 00:58:41 PDT 2020}}}} 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6e719945 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7372198f 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3b8e2ef5 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=1] Connector state changed: null->connecting 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=1] DNS entry stored in session object: localhost:5222 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=1] Preparing connection to [localhost:5222] 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@30bf09e2 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@52e61501 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=1] Connector state changed: connecting->connected 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=1] Whitespace ping period is setted to nullms 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=3159] Start TLS 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=3161] Proceeding TLS 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=3161] Start handshake 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19xOTJpcTAyMDkscj03YWNCb3AwNzR4Nll6UkUzSDR1dQ==</auth> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03YWNCb3AwNzR4Nll6UkUzSDR1dXEydHNqSVhFSmg4WVRJQ2xLQ3FGLHM9OUVQMHJBeTBNaGo4NFE9PSxpPTQwOTY=</challenge> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N2FjQm9wMDc0eDZZelJFM0g0dXVxMnRzaklYRUpoOFlUSUNsS0NxRixwPTFMZEV2UG1IdUVvckd5cnZHbWdGMk5VUW55KzM2dXF0bFlDeTlNWFpWUGs9</response> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1QcG9uY2xGOGFWQlRsZk5tQWFwWjJIcXRiaEpXMHVaZFUvOVhSclo4b0JBPQ==</success> 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="O32Fme9G+VEjEVujF8PPMQfI74w=" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost >> <iq xmlns="jabber:client" id="qPa9oSYoOGQRbqlaJQJP3yn" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost << <iq to="http-admin__q92iq0209@localhost/2095755800-tigase-231" xmlns="jabber:client" id="qPa9oSYoOGQRbqlaJQJP3yn" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__q92iq0209@localhost/2095755800-tigase-231</jid></bind></iq> 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost/2095755800-tigase-231 >> <iq xmlns="jabber:client" id="0t4GQRbqlaJQJP3ynLGohXg" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost/2095755800-tigase-231 << <iq to="http-admin__q92iq0209@localhost/2095755800-tigase-231" xmlns="jabber:client" id="0t4GQRbqlaJQJP3ynLGohXg" type="result"/> 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost/2095755800-tigase-231 >> <iq to="localhost" id="4Vok9MXiDDFMPFu0vpaCAlY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost/2095755800-tigase-231 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost/2095755800-tigase-231 << <enabled location="9585556aacac" resume="true" xmlns="urn:xmpp:sm:3" id="ca714dae-69e9-4afb-8906-5f335b124391" max="60"/> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost/2095755800-tigase-231 >> <iq id="vVmewwdTQbQ5y9FJU5bw4DF" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost/2095755800-tigase-231 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost/2095755800-tigase-231 << <iq to="http-admin__q92iq0209@localhost/2095755800-tigase-231" xmlns="jabber:client" id="4Vok9MXiDDFMPFu0vpaCAlY" from="localhost" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10742/15d7a283"/><identity type="im" category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10742/15d7a283"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost/2095755800-tigase-231 << <iq to="http-admin__q92iq0209@localhost/2095755800-tigase-231" xmlns="jabber:client" id="vVmewwdTQbQ5y9FJU5bw4DF" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=1] Connector state changed: connected->disconnecting 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=1] Terminating XMPP Stream 2020-05-27 00:58:41 | http-admin_ :: http-admin__q92iq0209@localhost/2095755800-tigase-231 << <presence to="http-admin__q92iq0209@localhost" xmlns="jabber:client" from="http-admin__q92iq0209@localhost/2095755800-tigase-231"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=3161] Connector state changed: disconnecting->disconnected 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=500 thread=3161] Stream terminated 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Using XEP-0077 mode!!!! 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Connector state changed: null->connecting 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@68cc55f9 2020-05-27 00:58:41 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@660bb690}, 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@62343e89}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2736bcab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2ddf4629}, 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=Wed May 27 00:58:41 PDT 2020}}}} 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] DNS entry stored in session object: localhost:5222 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Preparing connection to [localhost:5222] 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Connector state changed: connecting->connected 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Whitespace ping period is setted to nullms 2020-05-27 00:58:41 | [Mutex] waiting for: [registration] 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@165bda34 2020-05-27 00:58:41 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@660bb690}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@62343e89}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2736bcab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2ddf4629}, 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=Wed May 27 00:58:41 PDT 2020}}}} 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@55587e00 2020-05-27 00:58:41 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@471943e4} 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=3166] Start TLS 2020-05-27 00:58:41 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-05-27 00:58:41 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-27 00:58:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=3168] Proceeding TLS 2020-05-27 00:58:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=3168] Start handshake 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@10a0bb20 2020-05-27 00:58:41 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5862597a 2020-05-27 00:58:42 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4e5c9408} 2020-05-27 00:58:42 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-05-27 00:58:42 | http-admin_ :: null >> <iq to="localhost" id="GxabLYdr26HNWaGxmXjX06q" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-05-27 00:58:42 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@649c6a88} 2020-05-27 00:58:42 | http-admin_ :: null << <iq xmlns="jabber:client" id="GxabLYdr26HNWaGxmXjX06q" from="localhost" type="result"><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 xmlns="jabber:x:data" type="form"><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 var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field var="username" label="Username" type="text-single"><required/><value/></field><field var="password" label="Password" type="text-private"><required/><value/></field><field var="email" label="Email (MUST BE VALID!)" type="text-single"><required/><value/></field></x></query></iq> 2020-05-27 00:58:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4357f844} 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@56bb32b5 2020-05-27 00:58:42 | http-admin_ :: null >> <iq to="localhost" id="TGzU3vlMEwu04CphCJWhWVd" type="set"><query xmlns="jabber:iq:register"><username>http-admin__gtjlyn0210</username><password>http-admin__gtjlyn0210</password><email>10e666d0-e761-481c-b112-8fb2961402d2@localhost</email></query></iq> 2020-05-27 00:58:42 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2bfb57e8} 2020-05-27 00:58:42 | http-admin_ :: null << <iq xmlns="jabber:client" id="TGzU3vlMEwu04CphCJWhWVd" from="localhost" type="result"/> 2020-05-27 00:58:42 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1cd80891} 2020-05-27 00:58:42 | [Mutex] received everything. 2020-05-27 00:58:42 | [Mutex] isItemNotified: registrationSuccess :: true 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Connector state changed: connected->disconnecting 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=1] Terminating XMPP Stream 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=3168] Connector state changed: disconnecting->disconnected 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=501 thread=3168] Stream terminated 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-27 00:58:42 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@660bb690}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, 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@62343e89}, urn:xmpp:sm:3#SM_ACK_ENABLED=Entry{scope=stream, value=false}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2736bcab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2ddf4629}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed May 27 00:58:42 PDT 2020}}}} 2020-05-27 00:58:42 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@660bb690}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, 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@62343e89}, urn:xmpp:sm:3#SM_ACK_ENABLED=Entry{scope=stream, value=false}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2736bcab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2ddf4629}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed May 27 00:58:42 PDT 2020}}}} 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@368e23d6 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4ae7789b 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@45c6c5e8 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1986d141 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@5ed1c134 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Connector state changed: null->connecting 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] DNS entry stored in session object: localhost:5222 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Preparing connection to [localhost:5222] 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Connector state changed: connecting->connected 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=1] Whitespace ping period is setted to nullms 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=3173] Start TLS 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=3175] Proceeding TLS 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=3175] Start handshake 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19ndGpseW4wMjEwLHI9UlcyVXBDNkR2allLY1FJT21UTEk=</auth> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SVzJVcEM2RHZqWUtjUUlPbVRMSTZRdDRYOW9aemt2VHJWcGRRbkhDLHM9ZGkxTXo3MVZZWnh1cVE9PSxpPTQwOTY=</challenge> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UlcyVXBDNkR2allLY1FJT21UTEk2UXQ0WDlvWnprdlRyVnBkUW5IQyxwPVVFcHM2RVVZTVZhUVBpSVQ1L3hCejJJaGZHVmhCOG1JTHpEekc1MmVGL2c9</response> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1MNUVHVzRSdldxdjFpNSt1b1RtUHIya0tuY1UrckxIM0I4MXhVSUEydDRjPQ==</success> 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="O32Fme9G+VEjEVujF8PPMQfI74w=" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost >> <iq xmlns="jabber:client" id="70vTan7DIHpYYrhU6yhQVfP" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost << <iq to="http-admin__gtjlyn0210@localhost/2095755800-tigase-232" xmlns="jabber:client" id="70vTan7DIHpYYrhU6yhQVfP" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__gtjlyn0210@localhost/2095755800-tigase-232</jid></bind></iq> 2020-05-27 00:58:42 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 >> <iq xmlns="jabber:client" id="rS5KAoeu2yh16HS9GpbLYdr" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 << <iq to="http-admin__gtjlyn0210@localhost/2095755800-tigase-232" xmlns="jabber:client" id="rS5KAoeu2yh16HS9GpbLYdr" type="result"/> 2020-05-27 00:58:42 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 >> <iq to="localhost" id="IXiwjDqSfT8ys5s9HJycCGo" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 << <enabled location="9585556aacac" resume="true" xmlns="urn:xmpp:sm:3" id="69dfeb81-811f-4c7f-b6f7-67c38ac29bb9" max="60"/> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 >> <iq id="1Diyh16HS9GpbLYdr26HNWa" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 << <iq to="http-admin__gtjlyn0210@localhost/2095755800-tigase-232" xmlns="jabber:client" id="IXiwjDqSfT8ys5s9HJycCGo" from="localhost" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10742/15d7a283"/><identity type="im" category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10742/15d7a283"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 << <iq to="http-admin__gtjlyn0210@localhost/2095755800-tigase-232" xmlns="jabber:client" id="1Diyh16HS9GpbLYdr26HNWa" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 >> <message to="http-admin__q92iq0209@localhost" id="YGpo0sWWmTfyBGLUR5zArTW"><body>Test message 1</body></message> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 << <presence to="http-admin__gtjlyn0210@localhost" xmlns="jabber:client" from="http-admin__gtjlyn0210@localhost/2095755800-tigase-232"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> 2020-05-27 00:58:42 | http-admin_ :: http-admin__gtjlyn0210@localhost/2095755800-tigase-232 >> <message to="http-admin__q92iq0209@localhost" id="RT0QR0fT7kKISMCIBFoh2tk"><body>Test message 2</body></message> 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=3175] Connector state changed: connected->disconnected 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=502 thread=3175] Stream terminated 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
testGetUserInfoUserOnline | 1.357s |
2020-05-27 00:58:45 |
2020-05-27 00:58:45 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-05-27 00:58:45 | ------------------------------------ 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Using XEP-0077 mode!!!! 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Connector state changed: null->connecting 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@45edbe20 2020-05-27 00:58:45 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b2a48ed}, 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@4f15d550}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@a1742d6}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2223f10a}, 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=Wed May 27 00:58:45 PDT 2020}}}} 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] DNS entry stored in session object: localhost:5222 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Preparing connection to [localhost:5222] 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Connector state changed: connecting->connected 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Whitespace ping period is setted to nullms 2020-05-27 00:58:45 | [Mutex] waiting for: [registration] 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3bd7a883 2020-05-27 00:58:45 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b2a48ed}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@4f15d550}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@a1742d6}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2223f10a}, 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=Wed May 27 00:58:45 PDT 2020}}}} 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@5a0945fc 2020-05-27 00:58:45 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:45 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6a38bd99} 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=3180] Start TLS 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=3182] Proceeding TLS 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=3182] Start handshake 2020-05-27 00:58:45 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-05-27 00:58:45 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-27 00:58:45 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@572eba75 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@513b83a3 2020-05-27 00:58:45 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:45 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@410d0add} 2020-05-27 00:58:45 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-05-27 00:58:45 | http-admin_ :: null >> <iq to="localhost" id="k0fgSV8vp9oSYoOGQRbqlaJ" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-05-27 00:58:45 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5292e105} 2020-05-27 00:58:45 | http-admin_ :: null << <iq xmlns="jabber:client" id="k0fgSV8vp9oSYoOGQRbqlaJ" from="localhost" type="result"><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 xmlns="jabber:x:data" type="form"><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 var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field var="username" label="Username" type="text-single"><required/><value/></field><field var="password" label="Password" type="text-private"><required/><value/></field><field var="email" label="Email (MUST BE VALID!)" type="text-single"><required/><value/></field></x></query></iq> 2020-05-27 00:58:45 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6e76a310} 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@4c2951b9 2020-05-27 00:58:45 | http-admin_ :: null >> <iq to="localhost" id="X0d06qiCi4j5eXobKxrh0hz" type="set"><query xmlns="jabber:iq:register"><username>http-admin__14pcnx0211</username><password>http-admin__14pcnx0211</password><email>532e43d9-cebe-4dac-a229-73f3050fc06a@localhost</email></query></iq> 2020-05-27 00:58:45 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a164c352} 2020-05-27 00:58:45 | http-admin_ :: null << <iq xmlns="jabber:client" id="X0d06qiCi4j5eXobKxrh0hz" from="localhost" type="result"/> 2020-05-27 00:58:45 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4182e504} 2020-05-27 00:58:45 | [Mutex] received everything. 2020-05-27 00:58:45 | [Mutex] isItemNotified: registrationSuccess :: true 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Connector state changed: connected->disconnecting 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=1] Terminating XMPP Stream 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=3182] Connector state changed: disconnecting->disconnected 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=503 thread=3182] Stream terminated 2020-05-27 00:58:45 | 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;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6a38bd99, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@410d0add]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b2a48ed}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@4f15d550}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@a1742d6}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2223f10a}, 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=Wed May 27 00:58:45 PDT 2020}}}} 2020-05-27 00:58:45 | 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;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6a38bd99, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@410d0add]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4b2a48ed}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@4f15d550}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@a1742d6}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2223f10a}, 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=Wed May 27 00:58:45 PDT 2020}}}} 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@68f0440b 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@33c51426 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@35673f7e 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Connector state changed: null->connecting 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] DNS entry stored in session object: localhost:5222 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Preparing connection to [localhost:5222] 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Connector state changed: connecting->connected 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=1] Whitespace ping period is setted to nullms 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:45 | http-admin_ :: http-admin__14pcnx0211@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=3187] Start TLS 2020-05-27 00:58:45 | http-admin_ :: http-admin__14pcnx0211@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=3189] Proceeding TLS 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=504 thread=3189] Start handshake 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:45 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@631b4613 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@9a18667 2020-05-27 00:58:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX18xNHBjbngwMjExLHI9d3huYnhTUFA5alNFcTd5anFBVks=</auth> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13eG5ieFNQUDlqU0VxN3lqcUFWS2NPSDVlUnJGYjJYd3k1bTFFMFczLHM9R2dPTEtwcmNQT0ptQlE9PSxpPTQwOTY=</challenge> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d3huYnhTUFA5alNFcTd5anFBVktjT0g1ZVJyRmIyWHd5NW0xRTBXMyxwPU5mRmNPVTQwNWk4Z2hhaDNTWTZ1YkQ1NzFubkt1NXhwM1A4QUw5eUdraTg9</response> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj01dWdjQVM3bzNYaTJrZVZENis4NFRCbFNpZFFXeTlsYVVWM1NjTHBtdWdnPQ==</success> 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="O32Fme9G+VEjEVujF8PPMQfI74w=" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost >> <iq xmlns="jabber:client" id="YMvAoeu2yh16HS9GpbLYdr2" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost << <iq to="http-admin__14pcnx0211@localhost/2095755800-tigase-233" xmlns="jabber:client" id="YMvAoeu2yh16HS9GpbLYdr2" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__14pcnx0211@localhost/2095755800-tigase-233</jid></bind></iq> 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost/2095755800-tigase-233 >> <iq xmlns="jabber:client" id="pWXNVWYaMAeW3zcTgVevn9K" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost/2095755800-tigase-233 << <iq to="http-admin__14pcnx0211@localhost/2095755800-tigase-233" xmlns="jabber:client" id="pWXNVWYaMAeW3zcTgVevn9K" type="result"/> 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost/2095755800-tigase-233 >> <iq to="localhost" id="eZ4DqSfT8ys5s9HJycCGoQa" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost/2095755800-tigase-233 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost/2095755800-tigase-233 << <enabled location="9585556aacac" resume="true" xmlns="urn:xmpp:sm:3" id="e5988ab8-8831-4ef9-b2fa-6c2b8b15caaf" max="60"/> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost/2095755800-tigase-233 >> <iq id="o18Zn5gCsmKyAl9mdUdOFHN" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost/2095755800-tigase-233 << <iq to="http-admin__14pcnx0211@localhost/2095755800-tigase-233" xmlns="jabber:client" id="eZ4DqSfT8ys5s9HJycCGoQa" from="localhost" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10742/15d7a283"/><identity type="im" category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10742/15d7a283"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost/2095755800-tigase-233 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost/2095755800-tigase-233 << <iq to="http-admin__14pcnx0211@localhost/2095755800-tigase-233" xmlns="jabber:client" id="o18Zn5gCsmKyAl9mdUdOFHN" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-05-27 00:58:46 | http-admin_ :: http-admin__14pcnx0211@localhost/2095755800-tigase-233 << <presence to="http-admin__14pcnx0211@localhost" xmlns="jabber:client" from="http-admin__14pcnx0211@localhost/2095755800-tigase-233"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> |
testModifyUser | 2.433s |
2020-05-27 00:58:46 |
2020-05-27 00:58:46 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2020-05-27 00:58:46 | ------------------------------------ 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Using XEP-0077 mode!!!! 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Connector state changed: null->connecting 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@393c1112 2020-05-27 00:58:46 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37fbf845}, 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@33c47a62}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76c6f27e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2f2bc935}, 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=Wed May 27 00:58:46 PDT 2020}}}} 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] DNS entry stored in session object: localhost:5222 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Preparing connection to [localhost:5222] 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Connector state changed: connecting->connected 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Whitespace ping period is setted to nullms 2020-05-27 00:58:46 | [Mutex] waiting for: [registration] 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@47fa2545 2020-05-27 00:58:46 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37fbf845}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@33c47a62}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76c6f27e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2f2bc935}, 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=Wed May 27 00:58:46 PDT 2020}}}} 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@57fd40b2 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=3193] Start TLS 2020-05-27 00:58:46 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-05-27 00:58:46 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:46 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@16e90d31} 2020-05-27 00:58:46 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-27 00:58:46 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=3195] Proceeding TLS 2020-05-27 00:58:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=3195] Start handshake 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@67fa1cb8 2020-05-27 00:58:46 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@713cdd0f 2020-05-27 00:58:47 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:47 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4cf9eb4a} 2020-05-27 00:58:47 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2020-05-27 00:58:47 | http-admin_ :: null >> <iq to="localhost" id="e16Hy8LVcGIBudPZ4eGOEmc" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-05-27 00:58:47 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d7cae103} 2020-05-27 00:58:47 | http-admin_ :: null << <iq xmlns="jabber:client" id="e16Hy8LVcGIBudPZ4eGOEmc" from="localhost" type="result"><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 xmlns="jabber:x:data" type="form"><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 var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field var="username" label="Username" type="text-single"><required/><value/></field><field var="password" label="Password" type="text-private"><required/><value/></field><field var="email" label="Email (MUST BE VALID!)" type="text-single"><required/><value/></field></x></query></iq> 2020-05-27 00:58:47 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@12a7f761} 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@258f3651 2020-05-27 00:58:47 | http-admin_ :: null >> <iq to="localhost" id="JdE37oO7DCwoXcDFFqW6EkI" type="set"><query xmlns="jabber:iq:register"><username>http-admin__pdh210212</username><password>http-admin__pdh210212</password><email>802df237-4094-4404-97ea-90c1dbbcd7d5@localhost</email></query></iq> 2020-05-27 00:58:47 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@69c7c7b0} 2020-05-27 00:58:47 | http-admin_ :: null << <iq xmlns="jabber:client" id="JdE37oO7DCwoXcDFFqW6EkI" from="localhost" type="result"/> 2020-05-27 00:58:47 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@324c434a} 2020-05-27 00:58:47 | [Mutex] received everything. 2020-05-27 00:58:47 | [Mutex] isItemNotified: registrationSuccess :: true 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Connector state changed: connected->disconnecting 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=1] Terminating XMPP Stream 2020-05-27 00:58:47 | 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;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@16e90d31, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4cf9eb4a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37fbf845}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@33c47a62}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76c6f27e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2f2bc935}, 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=Wed May 27 00:58:47 PDT 2020}}}} 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=3195] Connector state changed: disconnecting->disconnected 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=505 thread=3195] Stream terminated 2020-05-27 00:58:47 | 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;@361f0171}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@16e90d31, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4cf9eb4a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@37fbf845}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6fcb7b98}, 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@33c47a62}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@76c6f27e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2f2bc935}, 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=Wed May 27 00:58:47 PDT 2020}}}} 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@31ec5df2 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@1cddb851 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@40bc3825 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@10ba756b 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@43eab943 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Connector state changed: null->connecting 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] DNS entry stored in session object: localhost:5222 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Preparing connection to [localhost:5222] 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Connector state changed: connecting->connected 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Whitespace ping period is setted to nullms 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=3200] Start TLS 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=3202] Proceeding TLS 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=3202] Start handshake 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19wZGgyMTAyMTIscj1BSEVUekdXWVBCbFBIdFdveUNGZg==</auth> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BSEVUekdXWVBCbFBIdFdveUNGZlY1VGdlUFZhbkFTbGZBMlExU284LHM9Z0hQa1doVStjSTBxb3c9PSxpPTQwOTY=</challenge> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QUhFVHpHV1lQQmxQSHRXb3lDRmZWNVRnZVBWYW5BU2xmQTJRMVNvOCxwPUVmaGJsTWxFcDR1cTBoaVZ3aGNnMTdvQkNDVWcxZFJpM0llVncvNDJjejA9</response> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1obTAzWWZqTnREUWNhREVXeUpNczUrbkNKVk5SZThkZ1hzQWdzeGFORC84PQ==</success> 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="O32Fme9G+VEjEVujF8PPMQfI74w=" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost >> <iq xmlns="jabber:client" id="H9qJU5bw4DFGEEteHNVWYaM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost << <iq to="http-admin__pdh210212@localhost/2095755800-tigase-234" xmlns="jabber:client" id="H9qJU5bw4DFGEEteHNVWYaM" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__pdh210212@localhost/2095755800-tigase-234</jid></bind></iq> 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost/2095755800-tigase-234 >> <iq xmlns="jabber:client" id="S9orazxpUU2w4cSVjGRcNYZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost/2095755800-tigase-234 << <iq to="http-admin__pdh210212@localhost/2095755800-tigase-234" xmlns="jabber:client" id="S9orazxpUU2w4cSVjGRcNYZ" type="result"/> 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost/2095755800-tigase-234 >> <iq to="localhost" id="ZUDYoOGQRbqlaJQJP3ynLGo" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost/2095755800-tigase-234 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost/2095755800-tigase-234 << <enabled location="9585556aacac" resume="true" xmlns="urn:xmpp:sm:3" id="0a55c7a3-906a-4649-8243-7140e17b2b84" max="60"/> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost/2095755800-tigase-234 >> <iq id="n0Tyl5v6iO4aogHRM3Azw5x" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost/2095755800-tigase-234 << <iq to="http-admin__pdh210212@localhost/2095755800-tigase-234" xmlns="jabber:client" id="ZUDYoOGQRbqlaJQJP3ynLGo" from="localhost" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10742/15d7a283"/><identity type="im" category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10742/15d7a283"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost/2095755800-tigase-234 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost/2095755800-tigase-234 << <iq to="http-admin__pdh210212@localhost/2095755800-tigase-234" xmlns="jabber:client" id="n0Tyl5v6iO4aogHRM3Azw5x" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Connector state changed: connected->disconnecting 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=1] Terminating XMPP Stream 2020-05-27 00:58:47 | http-admin_ :: http-admin__pdh210212@localhost/2095755800-tigase-234 << <presence to="http-admin__pdh210212@localhost" xmlns="jabber:client" from="http-admin__pdh210212@localhost/2095755800-tigase-234"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=3202] Connector state changed: disconnecting->disconnected 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=506 thread=3202] Stream terminated 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-27 00:58:47 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:47 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:49 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] Connector state changed: null->connecting 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] DNS entry stored in session object: localhost:5222 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] Preparing connection to [localhost:5222] 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] Connector state changed: connecting->connected 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=1] Whitespace ping period is setted to nullms 2020-05-27 00:58:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3200] Start TLS 2020-05-27 00:58:49 | http-admin_ :: http-admin__pdh210212@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:49 | http-admin_ :: http-admin__pdh210212@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3209] Proceeding TLS 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3209] Start handshake 2020-05-27 00:58:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-27 00:58:49 | http-admin_ :: http-admin__pdh210212@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-27 00:58:49 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-27 00:58:49 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-27 00:58:49 | http-admin_ :: http-admin__pdh210212@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19wZGgyMTAyMTIscj1nTTZKT3VKMXpZamNBa0M1U1RKTQ==</auth> 2020-05-27 00:58:49 | http-admin_ :: http-admin__pdh210212@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nTTZKT3VKMXpZamNBa0M1U1RKTXNIS2t4Snc2QkVFa0hoMHRBdGR4LHM9Z0hQa1doVStjSTBxb3c9PSxpPTQwOTY=</challenge> 2020-05-27 00:58:49 | http-admin_ :: http-admin__pdh210212@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z002Sk91SjF6WWpjQWtDNVNUSk1zSEtreEp3NkJFRWtIaDB0QXRkeCxwPTMxMUY4ZXVnVzVjTi96N3JQMS9hNWRRRjJmNVFhVUFhbDFOa3JmZG5mWTA9</response> 2020-05-27 00:58:49 | http-admin_ :: http-admin__pdh210212@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: http-admin__pdh210212@localhost is not authorized to act as http-admin__pdh210212@localhost</text></failure> 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3200] Connector state changed: connected->disconnecting 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3200] Terminating XMPP Stream 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3209] Connector state changed: disconnecting->disconnected 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3209] Stream terminated 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:49 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-27 00:58:49 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.Jaxmpp.onException: Catching exception 2020-05-27 00:58:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=507 thread=3200] Ignoring stop connector. |