UI: Web Admin UI - #2955

Test duration: 5.249s

Failed Tests
tigase.tests.http.TestAdminUI
testAddUser 0.012s
2019-10-13 19:55:17 |

2019-10-13 19:55:17 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-10-13 19:55:17 | ------------------------------------

java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471)
com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890)
com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395)
tigase.tests.http.TestAdminUI.testAddUser(TestAdminUI.java:102)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
java.base/java.lang.reflect.Method.invoke(Method.java:566)
org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
org.testng.internal.Invoker.invokeMethod(Invoker.java:583)
org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719)
org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989)
org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
org.testng.TestRunner.privateRun(TestRunner.java:648)
org.testng.TestRunner.run(TestRunner.java:505)
org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
org.testng.SuiteRunner.run(SuiteRunner.java:364)
org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
org.testng.TestNG.runSuites(TestNG.java:1049)
org.testng.TestNG.run(TestNG.java:1017)
org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283)
org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75)
org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120)
org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
testAuthorization 0.003s
2019-10-13 19:55:17 |

2019-10-13 19:55:17 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-10-13 19:55:17 | ------------------------------------

java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471)
com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890)
com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395)
tigase.tests.http.TestAdminUI.testAuthorization(TestAdminUI.java:76)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
java.base/java.lang.reflect.Method.invoke(Method.java:566)
org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
org.testng.internal.Invoker.invokeMethod(Invoker.java:583)
org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719)
org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989)
org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
org.testng.TestRunner.privateRun(TestRunner.java:648)
org.testng.TestRunner.run(TestRunner.java:505)
org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
org.testng.SuiteRunner.run(SuiteRunner.java:364)
org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
org.testng.TestNG.runSuites(TestNG.java:1049)
org.testng.TestNG.run(TestNG.java:1017)
org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283)
org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75)
org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120)
org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
testCommandsAvailability 0.001s
2019-10-13 19:55:17 |

2019-10-13 19:55:17 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-10-13 19:55:17 | ------------------------------------

java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471)
com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890)
com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395)
tigase.tests.http.TestAdminUI.testCommandsAvailability(TestAdminUI.java:89)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
java.base/java.lang.reflect.Method.invoke(Method.java:566)
org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
org.testng.internal.Invoker.invokeMethod(Invoker.java:583)
org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719)
org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989)
org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
org.testng.TestRunner.privateRun(TestRunner.java:648)
org.testng.TestRunner.run(TestRunner.java:505)
org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
org.testng.SuiteRunner.run(SuiteRunner.java:364)
org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
org.testng.TestNG.runSuites(TestNG.java:1049)
org.testng.TestNG.run(TestNG.java:1017)
org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283)
org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75)
org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120)
org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
testDeleteUser 0.187s
2019-10-13 19:55:17 |

2019-10-13 19:55:17 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-10-13 19:55:17 | ------------------------------------

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=1] Using XEP-0077 mode!!!!

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=1] Connector  state changed: null->connecting

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6360f0f

2019-10-13 19:55:17 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@8f1e1b9}, 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@cce647f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@49cceb82}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7fb4dbc3}, 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=Sun Oct 13 19:55:17 PDT 2019}}}}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=1] DNS entry stored in session object: localhost:5222

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=1] Preparing connection to [localhost:5222]

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=1] Connector  state changed: connecting->connected

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=1] Whitespace ping period is setted to nullms

2019-10-13 19:55:17 | [Mutex] waiting for: [registration]

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@78cf01a5

2019-10-13 19:55:17 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@8f1e1b9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@cce647f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@49cceb82}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7fb4dbc3}, 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=Sun Oct 13 19:55:17 PDT 2019}}}}

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@75d6f5f

2019-10-13 19:55:17 | 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>

2019-10-13 19:55:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@29e314cd}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=2498] Start TLS

2019-10-13 19:55:17 | 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>]

2019-10-13 19:55:17 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:55:17 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=2500] Proceeding TLS

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=2500] Start handshake

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7050a8f1

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@70124d77

2019-10-13 19:55:17 | 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>

2019-10-13 19:55:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1c59e3bd}

2019-10-13 19:55:17 | 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>]

2019-10-13 19:55:17 | http-admin_ :: null >> <iq to="localhost" id="EnceyhynWZdCiTPKx8rfONQ" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 19:55:17 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a1977641}

2019-10-13 19:55:17 | http-admin_ :: null << <iq from="localhost" id="EnceyhynWZdCiTPKx8rfONQ" xmlns="jabber:client" 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 to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq>

2019-10-13 19:55:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2dadc987}

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@584ffbe3

2019-10-13 19:55:17 | http-admin_ :: null >> <iq to="localhost" id="vspKT0s6v8mV4eDgNMFzkIJ" type="set"><query xmlns="jabber:iq:register"><username>http-admin__h8bzmr0160</username><password>http-admin__h8bzmr0160</password><email>bf4b0613-fc3b-4bb8-87d2-9dc8e99c7175@localhost</email></query></iq>

2019-10-13 19:55:17 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8ad96574}

2019-10-13 19:55:17 | http-admin_ :: null << <iq from="localhost" id="vspKT0s6v8mV4eDgNMFzkIJ" xmlns="jabber:client" type="result"/>

2019-10-13 19:55:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3a546c68}

2019-10-13 19:55:17 | [Mutex] received everything.

2019-10-13 19:55:17 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=1] Connector  state changed: connected->disconnecting

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=1] Terminating XMPP Stream

2019-10-13 19:55:17 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@29e314cd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1c59e3bd]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@8f1e1b9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@cce647f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@49cceb82}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7fb4dbc3}, 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=Sun Oct 13 19:55:17 PDT 2019}}}}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=2500] Connector  state changed: disconnecting->disconnected

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=398 thread=2500] Stream terminated

2019-10-13 19:55:17 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@29e314cd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1c59e3bd]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@8f1e1b9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@cce647f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@49cceb82}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7fb4dbc3}, 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=Sun Oct 13 19:55:17 PDT 2019}}}}

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@69433494

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2ae139ca

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@dd65f96

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@14f84568

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@64ef34f7

java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471)
com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890)
com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395)
tigase.tests.http.TestAdminUI.testDeleteUser(TestAdminUI.java:136)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
java.base/java.lang.reflect.Method.invoke(Method.java:566)
org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
org.testng.internal.Invoker.invokeMethod(Invoker.java:583)
org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719)
org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989)
org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
org.testng.TestRunner.privateRun(TestRunner.java:648)
org.testng.TestRunner.run(TestRunner.java:505)
org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
org.testng.SuiteRunner.run(SuiteRunner.java:364)
org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
org.testng.TestNG.runSuites(TestNG.java:1049)
org.testng.TestNG.run(TestNG.java:1017)
org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283)
org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75)
org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120)
org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
testGetUserInfoUserOffline 2.862s
2019-10-13 19:55:17 |

2019-10-13 19:55:17 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-10-13 19:55:17 | ------------------------------------

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=1] Using XEP-0077 mode!!!!

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=1] Connector  state changed: null->connecting

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6d4c5076

2019-10-13 19:55:17 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@638bb3af}, 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@67b43b06}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@22b6b994}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2df69254}, 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=Sun Oct 13 19:55:17 PDT 2019}}}}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=1] DNS entry stored in session object: localhost:5222

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=1] Preparing connection to [localhost:5222]

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=1] Connector  state changed: connecting->connected

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=1] Whitespace ping period is setted to nullms

2019-10-13 19:55:17 | [Mutex] waiting for: [registration]

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@13de5a8e

2019-10-13 19:55:17 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@638bb3af}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@67b43b06}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@22b6b994}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2df69254}, 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=Sun Oct 13 19:55:17 PDT 2019}}}}

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@55742ff8

2019-10-13 19:55:17 | 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>

2019-10-13 19:55:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@429946db}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=2505] Start TLS

2019-10-13 19:55:17 | 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>]

2019-10-13 19:55:17 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:55:17 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=2507] Proceeding TLS

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=2507] Start handshake

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5be408ee

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3a8f3336

2019-10-13 19:55:17 | 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>

2019-10-13 19:55:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4e70c070}

2019-10-13 19:55:17 | 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>]

2019-10-13 19:55:17 | http-admin_ :: null >> <iq to="localhost" id="nhOpbGxkW8xobACq9qW5oSV" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 19:55:17 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@31d1b584}

2019-10-13 19:55:17 | http-admin_ :: null << <iq from="localhost" id="nhOpbGxkW8xobACq9qW5oSV" xmlns="jabber:client" 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 to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq>

2019-10-13 19:55:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@46d7f8fb}

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3d8f2bb7

2019-10-13 19:55:17 | http-admin_ :: null >> <iq to="localhost" id="ceD9u5p04rVWVUZl0bCwiR2" type="set"><query xmlns="jabber:iq:register"><username>http-admin__qce4zj0161</username><password>http-admin__qce4zj0161</password><email>19742caa-dda4-42bc-a291-0130bed7f3b4@localhost</email></query></iq>

2019-10-13 19:55:17 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@82bfdea}

2019-10-13 19:55:17 | http-admin_ :: null << <iq from="localhost" id="ceD9u5p04rVWVUZl0bCwiR2" xmlns="jabber:client" type="result"/>

2019-10-13 19:55:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7e5aa9b3}

2019-10-13 19:55:17 | [Mutex] received everything.

2019-10-13 19:55:17 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=1] Connector  state changed: connected->disconnecting

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=1] Terminating XMPP Stream

2019-10-13 19:55:17 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@429946db, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4e70c070]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@638bb3af}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@67b43b06}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@22b6b994}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2df69254}, 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=Sun Oct 13 19:55:17 PDT 2019}}}}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=2507] Connector  state changed: disconnecting->disconnected

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=399 thread=2507] Stream terminated

2019-10-13 19:55:17 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@429946db, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4e70c070]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@638bb3af}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@67b43b06}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@22b6b994}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2df69254}, 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=Sun Oct 13 19:55:17 PDT 2019}}}}

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@36e19548

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@4f08b34f

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@b1efb8a

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@20a2cc6b

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1a5356e2

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=1] Connector  state changed: null->connecting

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=1] DNS entry stored in session object: localhost:5222

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=1] Preparing connection to [localhost:5222]

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=1] Connector  state changed: connecting->connected

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=1] Whitespace ping period is setted to nullms

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@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>

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=2512] Start TLS

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=2514] Proceeding TLS

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=2514] Start handshake

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@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>

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19xY2U0emowMTYxLHI9TVVNeU9EM3FZOWhta3N1ZXBONW4=</auth>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NVU15T0QzcVk5aG1rc3VlcE41bjYxR0lEUm5BTjdScUxNSDBYSU5tLHM9S2NuWlhicWMvR3gvQkE9PSxpPTQwOTY=</challenge>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TVVNeU9EM3FZOWhta3N1ZXBONW42MUdJRFJuQU43UnFMTUgwWElObSxwPWdUdVQwOUdody9yZHlmS0ZRTmVKaUVYUkhDa254MGhQS3RPQ3FPTXloSmM9</response>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1Jd0dsblBLZ2FrT1RlaWNpQ1pSM05OTG1ISXJLZ2NKcWJUd3pSQklWclNvPQ==</success>

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c ver="fD1ATDhYhT37hyTvdBFDDag+4EU=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost >> <iq xmlns="jabber:client" id="1ERyyiTUU1gCpOTY3lSOVTS" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost << <iq id="1ERyyiTUU1gCpOTY3lSOVTS" xmlns="jabber:client" type="result" to="http-admin__qce4zj0161@localhost/993927746-tigase-161"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__qce4zj0161@localhost/993927746-tigase-161</jid></bind></iq>

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 >> <iq xmlns="jabber:client" id="8tiqW36t8nZao5dw5eDDAlW" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 << <iq id="8tiqW36t8nZao5dw5eDDAlW" xmlns="jabber:client" type="result" to="http-admin__qce4zj0161@localhost/993927746-tigase-161"/>

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 >> <iq to="localhost" id="uxsNUdEKGFs0dEoXU5mPTY0" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 >> <iq id="rtekW8xobACq9qW5oSVQX6j" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 << <enabled location="d4270859fb27" id="2b2f41b8-c2e3-4732-a829-4097e3ea1e4f" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 << <iq from="localhost" id="uxsNUdEKGFs0dEoXU5mPTY0" xmlns="jabber:client" type="result" to="http-admin__qce4zj0161@localhost/993927746-tigase-161"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 << <iq id="rtekW8xobACq9qW5oSVQX6j" xmlns="jabber:client" type="result" to="http-admin__qce4zj0161@localhost/993927746-tigase-161"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=1] Connector  state changed: connected->disconnecting

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=1] Terminating XMPP Stream

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 << <presence from="http-admin__qce4zj0161@localhost/993927746-tigase-161" xmlns="jabber:client" to="http-admin__qce4zj0161@localhost"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp"/></presence>

2019-10-13 19:55:17 | http-admin_ :: http-admin__qce4zj0161@localhost/993927746-tigase-161 << <message from="localhost" xmlns="jabber:client" to="http-admin__qce4zj0161@localhost"><body>Wecome to eda3980f-6651-4b37-9ba7-1eab78362c5c
This message was set at: Sun Oct 13 19:45:03 PDT 2019</body><delay from="localhost" xmlns="urn:xmpp:delay" stamp="2019-10-14T02:55:17.685Z">Offline Storage - d4270859fb27</delay></message>

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=2514] Connector  state changed: disconnecting->disconnected

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=400 thread=2514] Stream terminated

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@289f4c51

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=1] Using XEP-0077 mode!!!!

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=1] Connector  state changed: null->connecting

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:17 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2658a732}, 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@22672721}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6765ad09}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@35ca9870}, 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=Sun Oct 13 19:55:17 PDT 2019}}}}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=1] DNS entry stored in session object: localhost:5222

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=1] Preparing connection to [localhost:5222]

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=1] Connector  state changed: connecting->connected

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5648c8cc

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=1] Whitespace ping period is setted to nullms

2019-10-13 19:55:17 | [Mutex] waiting for: [registration]

2019-10-13 19:55:17 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2658a732}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@22672721}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6765ad09}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@35ca9870}, 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=Sun Oct 13 19:55:17 PDT 2019}}}}

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@4d0da30b

2019-10-13 19:55:17 | 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>

2019-10-13 19:55:17 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@74a5246}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=2519] Start TLS

2019-10-13 19:55:17 | 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>]

2019-10-13 19:55:17 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:55:17 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=2521] Proceeding TLS

2019-10-13 19:55:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=2521] Start handshake

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@662253c7

2019-10-13 19:55:17 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@76bce967

2019-10-13 19:55:18 | 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>

2019-10-13 19:55:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@56090940}

2019-10-13 19:55:18 | 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>]

2019-10-13 19:55:18 | http-admin_ :: null >> <iq to="localhost" id="PCDVWVUZl0bCwiR2taMKNIw" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 19:55:18 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e66bd3d7}

2019-10-13 19:55:18 | http-admin_ :: null << <iq from="localhost" id="PCDVWVUZl0bCwiR2taMKNIw" xmlns="jabber:client" 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 to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq>

2019-10-13 19:55:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@304a9a5}

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@774c7e69

2019-10-13 19:55:18 | http-admin_ :: null >> <iq to="localhost" id="9ypwdq7qX9u2nNGpSVdKFAs" type="set"><query xmlns="jabber:iq:register"><username>http-admin__jgefj20162</username><password>http-admin__jgefj20162</password><email>908037ca-ded3-48a8-abff-0687cfc11876@localhost</email></query></iq>

2019-10-13 19:55:18 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3a9a2c62}

2019-10-13 19:55:18 | http-admin_ :: null << <iq from="localhost" id="9ypwdq7qX9u2nNGpSVdKFAs" xmlns="jabber:client" type="result"/>

2019-10-13 19:55:18 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@662a4636}

2019-10-13 19:55:18 | [Mutex] received everything.

2019-10-13 19:55:18 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=1] Connector  state changed: connected->disconnecting

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=1] Terminating XMPP Stream

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=2521] Connector  state changed: disconnecting->disconnected

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=401 thread=2521] Stream terminated

2019-10-13 19:55:18 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@74a5246, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@56090940]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2658a732}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@22672721}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6765ad09}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@35ca9870}, 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=Sun Oct 13 19:55:18 PDT 2019}}}}

2019-10-13 19:55:18 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@74a5246, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@56090940]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2658a732}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@22672721}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6765ad09}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@35ca9870}, 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=Sun Oct 13 19:55:18 PDT 2019}}}}

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@78f700ba

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@5e98d780

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4ab3450c

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=1] Connector  state changed: null->connecting

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=1] DNS entry stored in session object: localhost:5222

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=1] Preparing connection to [localhost:5222]

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=1] Connector  state changed: connecting->connected

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=1] Whitespace ping period is setted to nullms

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@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>

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=2525] Start TLS

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7e9ca19a

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3e2e8c23

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=2528] Proceeding TLS

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=2528] Start handshake

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@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>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19qZ2VmajIwMTYyLHI9TjhDSTlUNTZaSVpVank0U1lYOG0=</auth>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OOENJOVQ1NlpJWlVqeTRTWVg4bXZ3dVE5TTVzWVJkQWRqVG84MTd1LHM9K0YvN08yU3ZRVzBmS0E9PSxpPTQwOTY=</challenge>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TjhDSTlUNTZaSVpVank0U1lYOG12d3VROU01c1lSZEFkalRvODE3dSxwPTdGRTRiUkFNVGFMUlNENjd3aHlzYlN0SkRtMElwSXplOEdqeGt6RGJwaE09</response>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0yYTVpb0Z0bURwc0JKRE1DakkreFU4clptd2x6QnRPdXdiNCtZV0RUdFZZPQ==</success>

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c ver="fD1ATDhYhT37hyTvdBFDDag+4EU=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost >> <iq xmlns="jabber:client" id="zN60jKAnY2fufGtbyaDjIt0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost << <iq id="zN60jKAnY2fufGtbyaDjIt0" xmlns="jabber:client" type="result" to="http-admin__jgefj20162@localhost/993927746-tigase-162"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__jgefj20162@localhost/993927746-tigase-162</jid></bind></iq>

2019-10-13 19:55:18 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 >> <iq xmlns="jabber:client" id="Cu90dEoXU5mPTY0jFqTQR5u" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 << <iq id="Cu90dEoXU5mPTY0jFqTQR5u" xmlns="jabber:client" type="result" to="http-admin__jgefj20162@localhost/993927746-tigase-162"/>

2019-10-13 19:55:18 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 >> <iq to="localhost" id="fu75mMRLChCpbGxkW8xobAC" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 << <enabled location="d4270859fb27" id="9e239938-1d96-4590-a71c-2c31f861f45c" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 >> <iq id="Du5Zcu9iRUV5mMRLChCpbGx" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 << <iq from="localhost" id="fu75mMRLChCpbGxkW8xobAC" xmlns="jabber:client" type="result" to="http-admin__jgefj20162@localhost/993927746-tigase-162"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 << <iq id="Du5Zcu9iRUV5mMRLChCpbGx" xmlns="jabber:client" type="result" to="http-admin__jgefj20162@localhost/993927746-tigase-162"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 >> <message to="http-admin__qce4zj0161@localhost" id="oAlFEtcGCvk3k6o5iGzmONA"><body>Test message 1</body></message>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 << <presence from="http-admin__jgefj20162@localhost/993927746-tigase-162" xmlns="jabber:client" to="http-admin__jgefj20162@localhost"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp"/></presence>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 << <message from="localhost" xmlns="jabber:client" to="http-admin__jgefj20162@localhost"><body>Wecome to eda3980f-6651-4b37-9ba7-1eab78362c5c
This message was set at: Sun Oct 13 19:45:03 PDT 2019</body><delay from="localhost" xmlns="urn:xmpp:delay" stamp="2019-10-14T02:55:18.153Z">Offline Storage - d4270859fb27</delay></message>

2019-10-13 19:55:18 | http-admin_ :: http-admin__jgefj20162@localhost/993927746-tigase-162 >> <message to="http-admin__qce4zj0161@localhost" id="oBmHIBscEzsjQ8sdycBqW36"><body>Test message 2</body></message>

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=2528] Connector  state changed: connected->disconnected

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=402 thread=2528] Stream terminated

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471)
com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890)
com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395)
tigase.tests.http.TestAdminUI.testGetUserInfoUserOffline(TestAdminUI.java:287)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
java.base/java.lang.reflect.Method.invoke(Method.java:566)
org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
org.testng.internal.Invoker.invokeMethod(Invoker.java:583)
org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719)
org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989)
org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
org.testng.TestRunner.privateRun(TestRunner.java:648)
org.testng.TestRunner.run(TestRunner.java:505)
org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
org.testng.SuiteRunner.run(SuiteRunner.java:364)
org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
org.testng.TestNG.runSuites(TestNG.java:1049)
org.testng.TestNG.run(TestNG.java:1017)
org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283)
org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75)
org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120)
org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
testGetUserInfoUserOnline 0.434s
2019-10-13 19:55:20 |

2019-10-13 19:55:20 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-10-13 19:55:20 | ------------------------------------

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=1] Using XEP-0077 mode!!!!

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=1] Connector  state changed: null->connecting

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@357f7fda

2019-10-13 19:55:20 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3bb89705}, 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@3f8714aa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7a859d3e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@344abc1b}, 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=Sun Oct 13 19:55:20 PDT 2019}}}}

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=1] DNS entry stored in session object: localhost:5222

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=1] Preparing connection to [localhost:5222]

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=1] Connector  state changed: connecting->connected

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=1] Whitespace ping period is setted to nullms

2019-10-13 19:55:20 | [Mutex] waiting for: [registration]

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4bb50528

2019-10-13 19:55:20 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3bb89705}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@3f8714aa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7a859d3e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@344abc1b}, 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=Sun Oct 13 19:55:20 PDT 2019}}}}

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@4c907ab0

2019-10-13 19:55:20 | 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>

2019-10-13 19:55:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1aaa6271}

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=2532] Start TLS

2019-10-13 19:55:20 | 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>]

2019-10-13 19:55:20 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:55:20 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=2534] Proceeding TLS

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=2534] Start handshake

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7b61bf5b

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@189e795a

2019-10-13 19:55:20 | 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>

2019-10-13 19:55:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5794d503}

2019-10-13 19:55:20 | 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>]

2019-10-13 19:55:20 | http-admin_ :: null >> <iq to="localhost" id="3VegPMEveyhynWZdCiTPKx8" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 19:55:20 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7e4d14a}

2019-10-13 19:55:20 | http-admin_ :: null << <iq from="localhost" id="3VegPMEveyhynWZdCiTPKx8" xmlns="jabber:client" 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 to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq>

2019-10-13 19:55:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1ee49c6a}

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6889638a

2019-10-13 19:55:20 | http-admin_ :: null >> <iq to="localhost" id="EHwSQRIHAhNMCx7kHs5xoXa" type="set"><query xmlns="jabber:iq:register"><username>http-admin__gypogu0163</username><password>http-admin__gypogu0163</password><email>f2d2f1e1-a19a-4ab3-a913-c8db782901f3@localhost</email></query></iq>

2019-10-13 19:55:20 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ff339db0}

2019-10-13 19:55:20 | http-admin_ :: null << <iq from="localhost" id="EHwSQRIHAhNMCx7kHs5xoXa" xmlns="jabber:client" type="result"/>

2019-10-13 19:55:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3b68368}

2019-10-13 19:55:20 | [Mutex] received everything.

2019-10-13 19:55:20 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=1] Connector  state changed: connected->disconnecting

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=1] Terminating XMPP Stream

2019-10-13 19:55:20 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1aaa6271, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5794d503]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3bb89705}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@3f8714aa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7a859d3e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@344abc1b}, 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=Sun Oct 13 19:55:20 PDT 2019}}}}

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=2534] Connector  state changed: disconnecting->disconnected

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=403 thread=2534] Stream terminated

2019-10-13 19:55:20 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1aaa6271, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5794d503]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3bb89705}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@3f8714aa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7a859d3e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@344abc1b}, 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=Sun Oct 13 19:55:20 PDT 2019}}}}

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@72fb62d0

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@48c6b729

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6bf00888

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@5c6a6b5d

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@75ae6fe2

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=404 thread=1] Connector  state changed: null->connecting

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=404 thread=1] DNS entry stored in session object: localhost:5222

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=404 thread=1] Preparing connection to [localhost:5222]

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=404 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=404 thread=1] Connector  state changed: connecting->connected

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=404 thread=1] Whitespace ping period is setted to nullms

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@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>

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=404 thread=2539] Start TLS

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=404 thread=2541] Proceeding TLS

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=404 thread=2541] Start handshake

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@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>

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19neXBvZ3UwMTYzLHI9TFJLVmlJa1BrVFVjWGFCMll0REU=</auth>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MUktWaUlrUGtUVWNYYUIyWXRERVN1bFFGSXdWbm9TSjJDM3NVTXF6LHM9ajk0L0doSXZaZ1N2L2c9PSxpPTQwOTY=</challenge>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TFJLVmlJa1BrVFVjWGFCMll0REVTdWxRRkl3Vm5vU0oyQzNzVU1xeixwPUZCQ2RCQTNVdyt6RW0rL3liUDcwUVhveVR0RWRCMk5PbWZad2p0NVFITnM9</response>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1WcFJsRFFFU1M2bjBwNEl3dUxDdWxRVHJBa2hQRjdpaTRlbjI1SVlRWmo0PQ==</success>

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c ver="fD1ATDhYhT37hyTvdBFDDag+4EU=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost >> <iq xmlns="jabber:client" id="oGrR2fKMOT6BqiMRQMLKAlG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost << <iq id="oGrR2fKMOT6BqiMRQMLKAlG" xmlns="jabber:client" type="result" to="http-admin__gypogu0163@localhost/993927746-tigase-163"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__gypogu0163@localhost/993927746-tigase-163</jid></bind></iq>

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 >> <iq xmlns="jabber:client" id="NIvGFnQJwdNUZeKKLQ5oeEB" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 << <iq id="NIvGFnQJwdNUZeKKLQ5oeEB" xmlns="jabber:client" type="result" to="http-admin__gypogu0163@localhost/993927746-tigase-163"/>

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 >> <iq to="localhost" id="uNIjWhM0cHw8taq12lSRX6g" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 << <enabled location="d4270859fb27" id="3dcdc594-6336-48c5-ab6c-de0997a58fc8" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 >> <iq id="hKxKNDmLAl3q1iS0hS9wuaD" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 << <iq from="localhost" id="uNIjWhM0cHw8taq12lSRX6g" xmlns="jabber:client" type="result" to="http-admin__gypogu0163@localhost/993927746-tigase-163"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 << <iq id="hKxKNDmLAl3q1iS0hS9wuaD" xmlns="jabber:client" type="result" to="http-admin__gypogu0163@localhost/993927746-tigase-163"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 << <presence from="http-admin__gypogu0163@localhost/993927746-tigase-163" xmlns="jabber:client" to="http-admin__gypogu0163@localhost"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp"/></presence>

2019-10-13 19:55:20 | http-admin_ :: http-admin__gypogu0163@localhost/993927746-tigase-163 << <message from="localhost" xmlns="jabber:client" to="http-admin__gypogu0163@localhost"><body>Wecome to eda3980f-6651-4b37-9ba7-1eab78362c5c
This message was set at: Sun Oct 13 19:45:03 PDT 2019</body><delay from="localhost" xmlns="urn:xmpp:delay" stamp="2019-10-14T02:55:20.594Z">Offline Storage - d4270859fb27</delay></message>

java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471)
com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890)
com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395)
tigase.tests.http.TestAdminUI.testGetUserInfoUserOnline(TestAdminUI.java:239)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
java.base/java.lang.reflect.Method.invoke(Method.java:566)
org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
org.testng.internal.Invoker.invokeMethod(Invoker.java:583)
org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719)
org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989)
org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
org.testng.TestRunner.privateRun(TestRunner.java:648)
org.testng.TestRunner.run(TestRunner.java:505)
org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
org.testng.SuiteRunner.run(SuiteRunner.java:364)
org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
org.testng.TestNG.runSuites(TestNG.java:1049)
org.testng.TestNG.run(TestNG.java:1017)
org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283)
org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75)
org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120)
org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
testModifyUser 0.433s
2019-10-13 19:55:20 |

2019-10-13 19:55:20 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-10-13 19:55:20 | ------------------------------------

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=1] Using XEP-0077 mode!!!!

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=1] Connector  state changed: null->connecting

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@14c84d7b

2019-10-13 19:55:20 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a0fb192}, 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@1e30260b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5b32bba9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@dc79621}, 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=Sun Oct 13 19:55:20 PDT 2019}}}}

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=1] DNS entry stored in session object: localhost:5222

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=1] Preparing connection to [localhost:5222]

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=1] Connector  state changed: connecting->connected

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=1] Whitespace ping period is setted to nullms

2019-10-13 19:55:20 | [Mutex] waiting for: [registration]

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6aa3252a

2019-10-13 19:55:20 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a0fb192}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@1e30260b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5b32bba9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@dc79621}, 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=Sun Oct 13 19:55:20 PDT 2019}}}}

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@75bc560b

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=2544] Start TLS

2019-10-13 19:55:20 | 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>]

2019-10-13 19:55:20 | 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>

2019-10-13 19:55:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b1d44e6}

2019-10-13 19:55:20 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:55:20 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=2546] Proceeding TLS

2019-10-13 19:55:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=2546] Start handshake

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@adaab3a

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@7923453e

2019-10-13 19:55:20 | 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>

2019-10-13 19:55:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6eb8581f}

2019-10-13 19:55:20 | 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>]

2019-10-13 19:55:20 | http-admin_ :: null >> <iq to="localhost" id="VW56n0iQXeRWkQZ6iNOIBcF" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 19:55:20 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f462ce22}

2019-10-13 19:55:20 | http-admin_ :: null << <iq from="localhost" id="VW56n0iQXeRWkQZ6iNOIBcF" xmlns="jabber:client" 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 to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq>

2019-10-13 19:55:20 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3f531b5a}

2019-10-13 19:55:20 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@608ff4f1

2019-10-13 19:55:20 | http-admin_ :: null >> <iq to="localhost" id="mD8W3tgHEAq7yveU0jKAnY2" type="set"><query xmlns="jabber:iq:register"><username>http-admin__h80egm0164</username><password>http-admin__h80egm0164</password><email>e6925c85-69ce-4844-a426-dfa303aa112b@localhost</email></query></iq>

2019-10-13 19:55:20 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5b4df65e}

2019-10-13 19:55:21 | http-admin_ :: null << <iq from="localhost" id="mD8W3tgHEAq7yveU0jKAnY2" xmlns="jabber:client" type="result"/>

2019-10-13 19:55:21 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@366576b}

2019-10-13 19:55:21 | [Mutex] received everything.

2019-10-13 19:55:21 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=1] Connector  state changed: connected->disconnecting

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=1] Terminating XMPP Stream

2019-10-13 19:55:21 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b1d44e6, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6eb8581f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a0fb192}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@1e30260b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5b32bba9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@dc79621}, 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=Sun Oct 13 19:55:21 PDT 2019}}}}

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=2546] Connector  state changed: disconnecting->disconnected

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=405 thread=2546] Stream terminated

2019-10-13 19:55:21 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@5502c20d}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b1d44e6, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6eb8581f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a0fb192}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@143fc836}, 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@1e30260b}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5b32bba9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@dc79621}, 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=Sun Oct 13 19:55:21 PDT 2019}}}}

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2fb28fb8

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@81cd8df

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@17ab9d51

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=1] Connector  state changed: null->connecting

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=1] DNS entry stored in session object: localhost:5222

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=1] Preparing connection to [localhost:5222]

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=1] Connector  state changed: connecting->connected

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=1] Whitespace ping period is setted to nullms

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@26474dc0

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1db3c9ff

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@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>

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=2551] Start TLS

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=2553] Proceeding TLS

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=2553] Start handshake

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@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>

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19oODBlZ20wMTY0LHI9RHI0d2J4cWhlVTlRcHVzWnFUc1o=</auth>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EcjR3YnhxaGVVOVFwdXNacVRzWldNNHd5TGhUUVpLSkxRdUhYWUViLHM9TjE2d25CclVPakJpcFE9PSxpPTQwOTY=</challenge>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RHI0d2J4cWhlVTlRcHVzWnFUc1pXTTR3eUxoVFFaS0pMUXVIWFlFYixwPVFDM0xhVVF3eDlub2w4SFNCZ2VwdW9oSVlEVFluNVgxSlRTTk5TVHd2Qkk9</response>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj00dkx6MFh6UGtHZmJPMEs1ajU5NGVDOWY5U3l2YmVnRVl2OWd5WmJPZDhBPQ==</success>

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c ver="fD1ATDhYhT37hyTvdBFDDag+4EU=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost >> <iq xmlns="jabber:client" id="LIlxgAtZ4bq1p8r8ymZiZcQ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost << <iq id="LIlxgAtZ4bq1p8r8ymZiZcQ" xmlns="jabber:client" type="result" to="http-admin__h80egm0164@localhost/993927746-tigase-164"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__h80egm0164@localhost/993927746-tigase-164</jid></bind></iq>

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 >> <iq xmlns="jabber:client" id="lIjhCpbGxkW8xobACq9qW5o" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 << <iq id="lIjhCpbGxkW8xobACq9qW5o" xmlns="jabber:client" type="result" to="http-admin__h80egm0164@localhost/993927746-tigase-164"/>

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 >> <iq to="localhost" id="hPCU7hElKFHIBscEzsjQ8sd" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 >> <iq id="BXYGs7s0bmZar7qU7hElKFH" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 << <enabled location="d4270859fb27" id="35f5ed3a-b700-47e7-8f88-ea072c868a0c" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 << <iq from="localhost" id="hPCU7hElKFHIBscEzsjQ8sd" xmlns="jabber:client" type="result" to="http-admin__h80egm0164@localhost/993927746-tigase-164"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 << <iq id="BXYGs7s0bmZar7qU7hElKFH" xmlns="jabber:client" type="result" to="http-admin__h80egm0164@localhost/993927746-tigase-164"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=1] Connector  state changed: connected->disconnecting

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=1] Terminating XMPP Stream

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 << <message from="localhost" xmlns="jabber:client" to="http-admin__h80egm0164@localhost"><body>Wecome to eda3980f-6651-4b37-9ba7-1eab78362c5c
This message was set at: Sun Oct 13 19:45:03 PDT 2019</body><delay from="localhost" xmlns="urn:xmpp:delay" stamp="2019-10-14T02:55:21.037Z">Offline Storage - d4270859fb27</delay></message>

2019-10-13 19:55:21 | http-admin_ :: http-admin__h80egm0164@localhost/993927746-tigase-164 << <presence from="http-admin__h80egm0164@localhost/993927746-tigase-164" xmlns="jabber:client" to="http-admin__h80egm0164@localhost"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp"/></presence>

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-10-13 19:55:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=406 thread=2553] Connector  state changed: disconnecting->disconnected

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-10-13 19:55:21 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471)
com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890)
com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316)
com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410)
com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395)
tigase.tests.http.TestAdminUI.testModifyUser(TestAdminUI.java:163)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
java.base/java.lang.reflect.Method.invoke(Method.java:566)
org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124)
org.testng.internal.Invoker.invokeMethod(Invoker.java:583)
org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719)
org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989)
org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
org.testng.TestRunner.privateRun(TestRunner.java:648)
org.testng.TestRunner.run(TestRunner.java:505)
org.testng.SuiteRunner.runTest(SuiteRunner.java:455)
org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450)
org.testng.SuiteRunner.privateRun(SuiteRunner.java:415)
org.testng.SuiteRunner.run(SuiteRunner.java:364)
org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84)
org.testng.TestNG.runSuitesSequentially(TestNG.java:1208)
org.testng.TestNG.runSuitesLocally(TestNG.java:1137)
org.testng.TestNG.runSuites(TestNG.java:1049)
org.testng.TestNG.run(TestNG.java:1017)
org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283)
org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75)
org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120)
org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)