UI: Web Admin UI - #2955

Test duration: 5.715s

Failed Tests
tigase.tests.http.TestAdminUI
testAddUser 0.011s
2019-11-25 19:39:49 |

2019-11-25 19:39:49 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-25 19:39:49 | ------------------------------------

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.010s
2019-11-25 19:39:49 |

2019-11-25 19:39:49 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-25 19:39:49 | ------------------------------------

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.002s
2019-11-25 19:39:49 |

2019-11-25 19:39:49 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-25 19:39:49 | ------------------------------------

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.261s
2019-11-25 19:39:49 |

2019-11-25 19:39:49 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-25 19:39:49 | ------------------------------------

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Using XEP-0077 mode!!!!

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Connector  state changed: null->connecting

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@17284170

2019-11-25 19:39:49 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@19efade5}, 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@1dd02a00}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@58d2a7de}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@d244e75}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:49 PST 2019}}}}

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] DNS entry stored in session object: localhost:5222

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Preparing connection to [localhost:5222]

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Connector  state changed: connecting->connected

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Whitespace ping period is setted to nullms

2019-11-25 19:39:49 | [Mutex] waiting for: [registration]

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@69c05ab1

2019-11-25 19:39:49 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@19efade5}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@1dd02a00}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@58d2a7de}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@d244e75}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:49 PST 2019}}}}

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@75dceda3

2019-11-25 19:39:49 | 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-11-25 19:39:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@38fd5891}

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2941] Start TLS

2019-11-25 19:39:49 | 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-11-25 19:39:49 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 19:39:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2943] Proceeding TLS

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2943] Start handshake

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1705fe1d

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@7cfb3b9e

2019-11-25 19:39:49 | 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-11-25 19:39:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6ed86057}

2019-11-25 19:39:49 | 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-11-25 19:39:49 | http-admin_ :: null >> <iq to="localhost" id="xagwtfCFn5zeAubOPKuctqj" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 19:39:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2d1a8905}

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

2019-11-25 19:39:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3cb384cd}

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@47e6050

2019-11-25 19:39:49 | http-admin_ :: null >> <iq to="localhost" id="50KsXfTSS4l8t24mN4BHr7q" type="set"><query xmlns="jabber:iq:register"><username>http-admin__etvh1w0187</username><password>http-admin__etvh1w0187</password><email>60cdc82a-9db9-473d-8319-fbf66fb4665b@localhost</email></query></iq>

2019-11-25 19:39:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3bf3709d}

2019-11-25 19:39:49 | http-admin_ :: null << <iq type="result" id="50KsXfTSS4l8t24mN4BHr7q" from="localhost" xmlns="jabber:client"/>

2019-11-25 19:39:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@217c8c8a}

2019-11-25 19:39:49 | [Mutex] received everything.

2019-11-25 19:39:49 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Connector  state changed: connected->disconnecting

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Terminating XMPP Stream

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2943] Connector  state changed: disconnecting->disconnected

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2943] Stream terminated

2019-11-25 19:39:49 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@38fd5891, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6ed86057]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@19efade5}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@1dd02a00}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@58d2a7de}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@d244e75}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:49 PST 2019}}}}

2019-11-25 19:39:49 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@38fd5891, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6ed86057]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@19efade5}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@1dd02a00}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@58d2a7de}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@d244e75}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:49 PST 2019}}}}

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@c0b8a2a

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2c3ee28a

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5bb57bbd

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1e68a49d

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@4ee227a0

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 3.108s
2019-11-25 19:39:49 |

2019-11-25 19:39:49 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-25 19:39:49 | ------------------------------------

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Using XEP-0077 mode!!!!

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Connector  state changed: null->connecting

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2680cbf6

2019-11-25 19:39:49 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@28472156}, 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@2c78a086}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@697a2b6d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@490582cf}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:49 PST 2019}}}}

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] DNS entry stored in session object: localhost:5222

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Preparing connection to [localhost:5222]

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Connector  state changed: connecting->connected

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Whitespace ping period is setted to nullms

2019-11-25 19:39:49 | [Mutex] waiting for: [registration]

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@58594728

2019-11-25 19:39:49 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@28472156}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@2c78a086}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@697a2b6d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@490582cf}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:49 PST 2019}}}}

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@31ccb035

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2948] Start TLS

2019-11-25 19:39:49 | 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-11-25 19:39:49 | 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-11-25 19:39:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@955d422}

2019-11-25 19:39:49 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 19:39:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2950] Proceeding TLS

2019-11-25 19:39:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2950] Start handshake

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6ca32c3d

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@7ed14686

2019-11-25 19:39:49 | 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-11-25 19:39:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2ac81c71}

2019-11-25 19:39:49 | 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-11-25 19:39:49 | http-admin_ :: null >> <iq to="localhost" id="1djCFDodthX08AncBiAoRcR" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 19:39:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@8bb70ac5}

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

2019-11-25 19:39:49 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d1b29ce}

2019-11-25 19:39:49 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@78ac2e94

2019-11-25 19:39:49 | http-admin_ :: null >> <iq to="localhost" id="ZgqvmMRbNTUfxpdwaEvs7kE" type="set"><query xmlns="jabber:iq:register"><username>http-admin__u7calf0188</username><password>http-admin__u7calf0188</password><email>ba4a8665-7ce2-412b-9f39-42da27d5d031@localhost</email></query></iq>

2019-11-25 19:39:49 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@64deb261}

2019-11-25 19:39:50 | http-admin_ :: null << <iq type="result" id="ZgqvmMRbNTUfxpdwaEvs7kE" from="localhost" xmlns="jabber:client"/>

2019-11-25 19:39:50 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@cbdb271}

2019-11-25 19:39:50 | [Mutex] received everything.

2019-11-25 19:39:50 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Connector  state changed: connected->disconnecting

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Terminating XMPP Stream

2019-11-25 19:39:50 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@955d422, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2ac81c71]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@28472156}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@2c78a086}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@697a2b6d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@490582cf}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:50 PST 2019}}}}

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2950] Connector  state changed: disconnecting->disconnected

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2950] Stream terminated

2019-11-25 19:39:50 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@955d422, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2ac81c71]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@28472156}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@2c78a086}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@697a2b6d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@490582cf}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:50 PST 2019}}}}

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@66fc1c03

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@327d0c4b

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2bbc5c1e

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@4af34d22

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4ce95c7b

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Connector  state changed: null->connecting

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] DNS entry stored in session object: localhost:5222

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Preparing connection to [localhost:5222]

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Connector  state changed: connecting->connected

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Whitespace ping period is setted to nullms

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@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-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2955] Start TLS

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2957] Proceeding TLS

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2957] Start handshake

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@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-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX191N2NhbGYwMTg4LHI9VUNha3AyT3JWblFGUURwOHQySUY=</auth>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VQ2FrcDJPclZuUUZRRHA4dDJJRkFqcHd4WXYxMkpQV3dHd3gyUU9QLHM9dVFrME9mbkhnZGQvNGc9PSxpPTQwOTY=</challenge>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VUNha3AyT3JWblFGUURwOHQySUZBanB3eFl2MTJKUFd3R3d4MlFPUCxwPXpTcVArZGxLb1ZFYVU4enVvbTRUUmpzUzBGR29hb2xTQWd4SEdOSlRiK009</response>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1mQ0JiTFRYOFdTeW9ZbmRzb043bWl4OTlVUHh5eDRnODNncnlxMS9lbmZRPQ==</success>

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost >> <iq xmlns="jabber:client" id="viuzrl7xcPHJROKOP6pUOQL" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost << <iq to="http-admin__u7calf0188@localhost/993927746-tigase-208" type="result" id="viuzrl7xcPHJROKOP6pUOQL" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__u7calf0188@localhost/993927746-tigase-208</jid></bind></iq>

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost/993927746-tigase-208 >> <iq xmlns="jabber:client" id="lqQItbyeJXfCAeLZp7m9l1r" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost/993927746-tigase-208 << <iq to="http-admin__u7calf0188@localhost/993927746-tigase-208" type="result" id="lqQItbyeJXfCAeLZp7m9l1r" xmlns="jabber:client"/>

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost/993927746-tigase-208 >> <iq to="localhost" id="fb5NAoRcRdtbyeJXfCAeLZp" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost/993927746-tigase-208 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost/993927746-tigase-208 << <enabled max="60" resume="true" id="4d98fb98-84d0-4ce9-9bd7-73e92c0718a3" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost/993927746-tigase-208 >> <iq id="D2C6BiIKHQTSKIvurnNPQOT" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost/993927746-tigase-208 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost/993927746-tigase-208 << <iq to="http-admin__u7calf0188@localhost/993927746-tigase-208" type="result" id="fb5NAoRcRdtbyeJXfCAeLZp" from="localhost" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost/993927746-tigase-208 << <iq to="http-admin__u7calf0188@localhost/993927746-tigase-208" type="result" id="D2C6BiIKHQTSKIvurnNPQOT" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Connector  state changed: connected->disconnecting

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Terminating XMPP Stream

2019-11-25 19:39:50 | http-admin_ :: http-admin__u7calf0188@localhost/993927746-tigase-208 << <presence to="http-admin__u7calf0188@localhost" from="http-admin__u7calf0188@localhost/993927746-tigase-208" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence>

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2957] Connector  state changed: disconnecting->disconnected

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2957] Stream terminated

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Using XEP-0077 mode!!!!

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Connector  state changed: null->connecting

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7e50f573

2019-11-25 19:39:50 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@709704c9}, 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@74a89e03}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@31aa0ef2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@48a88ed9}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:50 PST 2019}}}}

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] DNS entry stored in session object: localhost:5222

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Preparing connection to [localhost:5222]

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Connector  state changed: connecting->connected

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Whitespace ping period is setted to nullms

2019-11-25 19:39:50 | [Mutex] waiting for: [registration]

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@517a49

2019-11-25 19:39:50 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@709704c9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@74a89e03}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@31aa0ef2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@48a88ed9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:50 PST 2019}}}}

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@30b9a4c6

2019-11-25 19:39:50 | 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-11-25 19:39:50 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5185f1bd}

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2962] Start TLS

2019-11-25 19:39:50 | 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-11-25 19:39:50 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 19:39:50 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2964] Proceeding TLS

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2964] Start handshake

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5d576312

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@565fd9c3

2019-11-25 19:39:50 | 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-11-25 19:39:50 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2bbdc85a}

2019-11-25 19:39:50 | 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-11-25 19:39:50 | http-admin_ :: null >> <iq to="localhost" id="04GcR9Bk5dLVW0kRaxakSP8" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 19:39:50 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@79cc0077}

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

2019-11-25 19:39:50 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@55cbcc89}

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@33626ad1

2019-11-25 19:39:50 | http-admin_ :: null >> <iq to="localhost" id="ZmxIMCxxvjKVT7DmQ0dSX00" type="set"><query xmlns="jabber:iq:register"><username>http-admin__2150hw0189</username><password>http-admin__2150hw0189</password><email>086aa559-87fc-42a3-99c4-a2bb9bf26de5@localhost</email></query></iq>

2019-11-25 19:39:50 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b691b6fb}

2019-11-25 19:39:50 | http-admin_ :: null << <iq type="result" id="ZmxIMCxxvjKVT7DmQ0dSX00" from="localhost" xmlns="jabber:client"/>

2019-11-25 19:39:50 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1bdb3cbf}

2019-11-25 19:39:50 | [Mutex] received everything.

2019-11-25 19:39:50 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Connector  state changed: connected->disconnecting

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Terminating XMPP Stream

2019-11-25 19:39:50 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5185f1bd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2bbdc85a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@709704c9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@74a89e03}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@31aa0ef2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@48a88ed9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:50 PST 2019}}}}

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2964] Connector  state changed: disconnecting->disconnected

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2964] Stream terminated

2019-11-25 19:39:50 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@5185f1bd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2bbdc85a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@709704c9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@74a89e03}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@31aa0ef2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@48a88ed9}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:50 PST 2019}}}}

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5e61d886

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@5545f847

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@755134dc

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Connector  state changed: null->connecting

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] DNS entry stored in session object: localhost:5222

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Preparing connection to [localhost:5222]

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Connector  state changed: connecting->connected

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Whitespace ping period is setted to nullms

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@37add00d

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@67589b96

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@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-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2969] Start TLS

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2971] Proceeding TLS

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2971] Start handshake

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@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-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX18yMTUwaHcwMTg5LHI9ZkVNV05NNTZtY045cXNiaFlXeXg=</auth>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mRU1XTk01Nm1jTjlxc2JoWVd5eHVPc0NuTldrZjBIdVFETEtPbDd2LHM9bEVFTlVUNmpoWXNwbVE9PSxpPTQwOTY=</challenge>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZkVNV05NNTZtY045cXNiaFlXeXh1T3NDbk5Xa2YwSHVRRExLT2w3dixwPTZ4dVJwMThZOEZ5K3pRcUxBY3ZLWGJHZDJ2Zm81WndNUmNKU1NLWGRncVU9</response>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zbDdKV1NsWVN5THpTQ3Q0M1E2WmMvRmhnWWFQazNPL2tpcXhqT0NvdHYwPQ==</success>

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost >> <iq xmlns="jabber:client" id="75GdPKCyj4lMykJWlbp3iIH" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost << <iq to="http-admin__2150hw0189@localhost/993927746-tigase-209" type="result" id="75GdPKCyj4lMykJWlbp3iIH" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__2150hw0189@localhost/993927746-tigase-209</jid></bind></iq>

2019-11-25 19:39:50 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 >> <iq xmlns="jabber:client" id="lwXVT1eArn5iWWbP5t4zbHN" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 << <iq to="http-admin__2150hw0189@localhost/993927746-tigase-209" type="result" id="lwXVT1eArn5iWWbP5t4zbHN" xmlns="jabber:client"/>

2019-11-25 19:39:50 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 >> <iq to="localhost" id="aaRm2h0dw2iFO5FnZasbR3e" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 << <enabled max="60" resume="true" id="46b867c4-09e2-42d9-8171-0e332c25d7cd" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 >> <iq id="HdYMLY9oMMDKXpRX6kVl1aG" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 << <iq to="http-admin__2150hw0189@localhost/993927746-tigase-209" type="result" id="aaRm2h0dw2iFO5FnZasbR3e" from="localhost" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 << <iq to="http-admin__2150hw0189@localhost/993927746-tigase-209" type="result" id="HdYMLY9oMMDKXpRX6kVl1aG" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 >> <message to="http-admin__u7calf0188@localhost" id="h6BWXofZ1hKCvvlOY0j5Bv8"><body>Test message 1</body></message>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 << <presence to="http-admin__2150hw0189@localhost" from="http-admin__2150hw0189@localhost/993927746-tigase-209" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence>

2019-11-25 19:39:50 | http-admin_ :: http-admin__2150hw0189@localhost/993927746-tigase-209 >> <message to="http-admin__u7calf0188@localhost" id="qf0N5v8CiTfV9qhBxt2cIDI"><body>Test message 2</body></message>

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2971] Connector  state changed: connected->disconnected

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2971] Stream terminated

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:52 | 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.418s
2019-11-25 19:39:52 |

2019-11-25 19:39:52 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-25 19:39:52 | ------------------------------------

2019-11-25 19:39:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Using XEP-0077 mode!!!!

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Connector  state changed: null->connecting

2019-11-25 19:39:52 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7eefafa0

2019-11-25 19:39:52 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@70284e0d}, 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@7417c4d0}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@31154436}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@32047f1b}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:52 PST 2019}}}}

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] DNS entry stored in session object: localhost:5222

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Preparing connection to [localhost:5222]

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Connector  state changed: connecting->connected

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Whitespace ping period is setted to nullms

2019-11-25 19:39:52 | [Mutex] waiting for: [registration]

2019-11-25 19:39:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:52 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6e1770

2019-11-25 19:39:52 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@70284e0d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@7417c4d0}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@31154436}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@32047f1b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:52 PST 2019}}}}

2019-11-25 19:39:52 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@4a9572e9

2019-11-25 19:39:52 | 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-11-25 19:39:52 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@513abb79}

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2975] Start TLS

2019-11-25 19:39:52 | 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-11-25 19:39:52 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 19:39:52 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2977] Proceeding TLS

2019-11-25 19:39:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2977] Start handshake

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@4057fae2

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3072b00f

2019-11-25 19:39:53 | 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-11-25 19:39:53 | 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-11-25 19:39:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@51919ed2}

2019-11-25 19:39:53 | http-admin_ :: null >> <iq to="localhost" id="mFaT1eArn5iWWbP5t4zbHNG" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 19:39:53 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@bd5ab3a5}

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

2019-11-25 19:39:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@557406ea}

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@2a0b664c

2019-11-25 19:39:53 | http-admin_ :: null >> <iq to="localhost" id="ghYs8laN5dFwaBHJAw6vtn3" type="set"><query xmlns="jabber:iq:register"><username>http-admin__6dset40190</username><password>http-admin__6dset40190</password><email>e24e0050-db5f-4c13-9541-3a2a58c84f17@localhost</email></query></iq>

2019-11-25 19:39:53 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ba37bc7f}

2019-11-25 19:39:53 | http-admin_ :: null << <iq type="result" id="ghYs8laN5dFwaBHJAw6vtn3" from="localhost" xmlns="jabber:client"/>

2019-11-25 19:39:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@fdc49ca}

2019-11-25 19:39:53 | [Mutex] received everything.

2019-11-25 19:39:53 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Connector  state changed: connected->disconnecting

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Terminating XMPP Stream

2019-11-25 19:39:53 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@513abb79, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@51919ed2]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@70284e0d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@7417c4d0}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@31154436}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@32047f1b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:53 PST 2019}}}}

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2977] Connector  state changed: disconnecting->disconnected

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2977] Stream terminated

2019-11-25 19:39:53 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@513abb79, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@51919ed2]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@70284e0d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@7417c4d0}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@31154436}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@32047f1b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:53 PST 2019}}}}

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@526631ed

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@27d02e1d

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@561805ad

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Connector  state changed: null->connecting

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3be784bd

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@586d3375

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] DNS entry stored in session object: localhost:5222

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Preparing connection to [localhost:5222]

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Connector  state changed: connecting->connected

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Whitespace ping period is setted to nullms

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@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-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2982] Start TLS

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2984] Proceeding TLS

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2984] Start handshake

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@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-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX182ZHNldDQwMTkwLHI9QWhMVXlrQzhTU0RPOWRLM1BSS00=</auth>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BaExVeWtDOFNTRE85ZEszUFJLTVBWMnh2dTBnc1pxNlFFUnRkTUc2LHM9dE5OQkdIRlNJSUdIdUE9PSxpPTQwOTY=</challenge>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QWhMVXlrQzhTU0RPOWRLM1BSS01QVjJ4dnUwZ3NacTZRRVJ0ZE1HNixwPXN0alBLTGRrSUoyMTZ5SFNWYUtOenJMbUxraUpjV3FFb2tDeEJxZ2dGdXM9</response>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj04S3JsTVh5YjJlU1M1Umt1L3JqUXV5VnJQdkJ6R3VFUWsyQWJlZkR0V1NzPQ==</success>

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost >> <iq xmlns="jabber:client" id="Bk57hTbs2oZq3co05EL15p0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost << <iq to="http-admin__6dset40190@localhost/993927746-tigase-210" type="result" id="Bk57hTbs2oZq3co05EL15p0" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__6dset40190@localhost/993927746-tigase-210</jid></bind></iq>

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost/993927746-tigase-210 >> <iq xmlns="jabber:client" id="ZyJ6yaDJT5i15vpUWcBEv6c" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost/993927746-tigase-210 << <iq to="http-admin__6dset40190@localhost/993927746-tigase-210" type="result" id="ZyJ6yaDJT5i15vpUWcBEv6c" xmlns="jabber:client"/>

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost/993927746-tigase-210 >> <iq to="localhost" id="wiVFN1lO39DFqYgJU18gKzC" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost/993927746-tigase-210 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost/993927746-tigase-210 << <enabled max="60" resume="true" id="44104af1-1574-471e-8214-5a1341ab1730" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost/993927746-tigase-210 >> <iq id="Gl2IKHQTSKIvurnNPQOThTU" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost/993927746-tigase-210 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost/993927746-tigase-210 << <iq to="http-admin__6dset40190@localhost/993927746-tigase-210" type="result" id="wiVFN1lO39DFqYgJU18gKzC" from="localhost" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost/993927746-tigase-210 << <iq to="http-admin__6dset40190@localhost/993927746-tigase-210" type="result" id="Gl2IKHQTSKIvurnNPQOThTU" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__6dset40190@localhost/993927746-tigase-210 << <presence to="http-admin__6dset40190@localhost" from="http-admin__6dset40190@localhost/993927746-tigase-210" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence>

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.495s
2019-11-25 19:39:53 |

2019-11-25 19:39:53 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-25 19:39:53 | ------------------------------------

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@613c4a1f

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Using XEP-0077 mode!!!!

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Connector  state changed: null->connecting

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] DNS entry stored in session object: localhost:5222

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Preparing connection to [localhost:5222]

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-25 19:39:53 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6ffba848}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@6bc4216f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2ec6a273}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2da97906}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:53 PST 2019}}}}

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Connector  state changed: connecting->connected

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Whitespace ping period is setted to nullms

2019-11-25 19:39:53 | [Mutex] waiting for: [registration]

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1fa22d13

2019-11-25 19:39:53 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6ffba848}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@6bc4216f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2ec6a273}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2da97906}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:53 PST 2019}}}}

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@5527a8d1

2019-11-25 19:39:53 | 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-11-25 19:39:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ee95d3c}

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2987] Start TLS

2019-11-25 19:39:53 | 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-11-25 19:39:53 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 19:39:53 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2989] Proceeding TLS

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2989] Start handshake

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@28ee6cae

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@26aa0615

2019-11-25 19:39:53 | 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-11-25 19:39:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4e234331}

2019-11-25 19:39:53 | 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-11-25 19:39:53 | http-admin_ :: null >> <iq to="localhost" id="Mm3CsZsnfxjOKL1nS6gP7FD" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-25 19:39:53 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@72585686}

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

2019-11-25 19:39:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4aa7e774}

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@11f77992

2019-11-25 19:39:53 | http-admin_ :: null >> <iq to="localhost" id="SMh7t8o3BxcKyphZhGNDBBi" type="set"><query xmlns="jabber:iq:register"><username>http-admin__wf1aol0191</username><password>http-admin__wf1aol0191</password><email>6c9db7e3-e1b7-41ac-9931-0d759b35774d@localhost</email></query></iq>

2019-11-25 19:39:53 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@bd565f8e}

2019-11-25 19:39:53 | http-admin_ :: null << <iq type="result" id="SMh7t8o3BxcKyphZhGNDBBi" from="localhost" xmlns="jabber:client"/>

2019-11-25 19:39:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@671b5f17}

2019-11-25 19:39:53 | [Mutex] received everything.

2019-11-25 19:39:53 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Connector  state changed: connected->disconnecting

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Terminating XMPP Stream

2019-11-25 19:39:53 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ee95d3c, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4e234331]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6ffba848}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@6bc4216f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2ec6a273}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2da97906}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:53 PST 2019}}}}

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2989] Connector  state changed: disconnecting->disconnected

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2989] Stream terminated

2019-11-25 19:39:53 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@20310e14}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ee95d3c, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4e234331]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6ffba848}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@7eff8d96}, 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@6bc4216f}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2ec6a273}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2da97906}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Nov 25 19:39:53 PST 2019}}}}

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@33f5b20e

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@461c6f43

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6c0db5fb

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Connector  state changed: null->connecting

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] DNS entry stored in session object: localhost:5222

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Preparing connection to [localhost:5222]

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Connector  state changed: connecting->connected

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Whitespace ping period is setted to nullms

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@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-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2994] Start TLS

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@51d3bc8a

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@4f28117c

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2996] Proceeding TLS

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2996] Start handshake

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@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-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX193ZjFhb2wwMTkxLHI9VjEwOVdTUVVkbzI5cU16YjJ5cnQ=</auth>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WMTA5V1NRVWRvMjlxTXpiMnlydGZKeHJ2ejZMbzRqV3BpRlVJdHQ0LHM9bytld3B3UytyaUZuU2c9PSxpPTQwOTY=</challenge>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VjEwOVdTUVVkbzI5cU16YjJ5cnRmSnhydno2TG80aldwaUZVSXR0NCxwPVBVa2NYdHlVZGFaK0tSZ2JWNHJTZ21RR1UzNU5iZWJGSmxZMlpEdVlOejQ9</response>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj11UXB3RlA4NUxvdmhDRW9tVTlTL1YvdzJ3dUZZT0tPYmg3eGV1RkZDam5VPQ==</success>

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" xmlns="http://jabber.org/protocol/caps"/></features>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost >> <iq xmlns="jabber:client" id="iwtxyzDjRUW9NVYiEBFLPMZ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost << <iq to="http-admin__wf1aol0191@localhost/993927746-tigase-211" type="result" id="iwtxyzDjRUW9NVYiEBFLPMZ" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__wf1aol0191@localhost/993927746-tigase-211</jid></bind></iq>

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost/993927746-tigase-211 >> <iq xmlns="jabber:client" id="brceFMLCeGrmbRLLIynfPMU" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost/993927746-tigase-211 << <iq to="http-admin__wf1aol0191@localhost/993927746-tigase-211" type="result" id="brceFMLCeGrmbRLLIynfPMU" xmlns="jabber:client"/>

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost/993927746-tigase-211 >> <iq to="localhost" id="cENj4lMykJWlbp3iIHT7m4c" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost/993927746-tigase-211 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost/993927746-tigase-211 << <enabled max="60" resume="true" id="1e775845-a1e9-4b9c-b675-e6a1f9949f84" location="d4270859fb27" xmlns="urn:xmpp:sm:3"/>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost/993927746-tigase-211 >> <iq id="utekIJVhRQ7hTbs2oZq3co0" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost/993927746-tigase-211 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost/993927746-tigase-211 << <iq to="http-admin__wf1aol0191@localhost/993927746-tigase-211" type="result" id="cENj4lMykJWlbp3iIHT7m4c" from="localhost" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost/993927746-tigase-211 << <iq to="http-admin__wf1aol0191@localhost/993927746-tigase-211" type="result" id="utekIJVhRQ7hTbs2oZq3co0" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Connector  state changed: connected->disconnecting

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Terminating XMPP Stream

2019-11-25 19:39:53 | http-admin_ :: http-admin__wf1aol0191@localhost/993927746-tigase-211 << <presence to="http-admin__wf1aol0191@localhost" from="http-admin__wf1aol0191@localhost/993927746-tigase-211" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence>

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2996] Connector  state changed: disconnecting->disconnected

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2996] Stream terminated

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-25 19:39:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-25 19:39:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-25 19:39:53 | 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.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)