UI: Web Admin UI - #2955

Test duration: 4.715s

Failed Tests
tigase.tests.http.TestAdminUI
testAddUser 0.028s
2019-11-27 19:19:59 |

2019-11-27 19:19:59 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-27 19:19:59 | ------------------------------------

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.004s
2019-11-27 19:19:59 |

2019-11-27 19:19:59 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-27 19:19:59 | ------------------------------------

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.000s
2019-11-27 19:19:59 |

2019-11-27 19:19:59 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-27 19:19:59 | ------------------------------------

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.215s
2019-11-27 19:19:59 |

2019-11-27 19:19:59 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-27 19:19:59 | ------------------------------------

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

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@344ab40e

2019-11-27 19:19:59 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3a8d5cf7}, 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@3eb2df7e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7bb056cc}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1abb7770}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:19:59 PST 2019}}}}

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

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

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

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

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

2019-11-27 19:19:59 | [Mutex] waiting for: [registration]

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4a81ea34

2019-11-27 19:19:59 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3a8d5cf7}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@3eb2df7e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7bb056cc}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1abb7770}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:19:59 PST 2019}}}}

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@62609535

2019-11-27 19:19:59 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:19:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1b9fa983}

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2950] Start TLS

2019-11-27 19:19:59 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

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

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

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2952] Proceeding TLS

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2952] Start handshake

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5ade4d77

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1fcbcc52

2019-11-27 19:19:59 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:19:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@79643ba3}

2019-11-27 19:19:59 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-27 19:19:59 | http-admin_ :: null >> <iq to="localhost" id="TxWq8IS9JOSR6tiPM0al9Bn" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 19:19:59 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7a2418f}

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

2019-11-27 19:19:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1fd156bd}

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@374c15c5

2019-11-27 19:19:59 | http-admin_ :: null >> <iq to="localhost" id="vmnn8xq5i2etp7p8tp6cTfT" type="set"><query xmlns="jabber:iq:register"><username>http-admin__rf5ees0190</username><password>http-admin__rf5ees0190</password><email>02f1e6d8-ff86-4cbe-94e1-d070007a75e5@localhost</email></query></iq>

2019-11-27 19:19:59 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5987ebdf}

2019-11-27 19:19:59 | http-admin_ :: null << <iq id="vmnn8xq5i2etp7p8tp6cTfT" from="localhost" xmlns="jabber:client" type="result"/>

2019-11-27 19:19:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@76a4e622}

2019-11-27 19:19:59 | [Mutex] received everything.

2019-11-27 19:19:59 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-27 19:19:59 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1b9fa983, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@79643ba3]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3a8d5cf7}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@3eb2df7e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7bb056cc}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1abb7770}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:19:59 PST 2019}}}}

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2952] Connector  state changed: disconnecting->disconnected

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2952] Stream terminated

2019-11-27 19:19:59 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1b9fa983, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@79643ba3]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3a8d5cf7}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@3eb2df7e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7bb056cc}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1abb7770}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:19:59 PST 2019}}}}

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2e457276

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@3bb4adbd

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6c016533

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3dc51b67

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3816186b

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

2019-11-27 19:19:59 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-27 19:19:59 | ------------------------------------

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

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Using XEP-0077 mode!!!!

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

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@352b0119

2019-11-27 19:19:59 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3bece9cc}, 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@3fd36a69}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7ad1e3f7}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@171f067d}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:19:59 PST 2019}}}}

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

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

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

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

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

2019-11-27 19:19:59 | [Mutex] waiting for: [registration]

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@4be13fdb

2019-11-27 19:19:59 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3bece9cc}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@3fd36a69}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7ad1e3f7}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@171f067d}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:19:59 PST 2019}}}}

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@6fc584ec

2019-11-27 19:19:59 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:19:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1afe1cb8}

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2957] Start TLS

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2959] Proceeding TLS

2019-11-27 19:19:59 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

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

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

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2959] Start handshake

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@75bdcd74

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@37602bff

2019-11-27 19:19:59 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:19:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@74c12b1b}

2019-11-27 19:19:59 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-27 19:19:59 | http-admin_ :: null >> <iq to="localhost" id="eB2SKZrh3mRam0sm7FGCl4p" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 19:19:59 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4c8c4914}

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1eb0e2e7

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

2019-11-27 19:19:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@57d5a28}

2019-11-27 19:19:59 | http-admin_ :: null >> <iq to="localhost" id="3vIbuq01vjNU1viAFNZtcxw" type="set"><query xmlns="jabber:iq:register"><username>http-admin__qkipl30191</username><password>http-admin__qkipl30191</password><email>07bbe5b4-ecee-4f3a-b842-6e7e6e6b22ab@localhost</email></query></iq>

2019-11-27 19:19:59 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@56e5c193}

2019-11-27 19:19:59 | http-admin_ :: null << <iq id="3vIbuq01vjNU1viAFNZtcxw" from="localhost" xmlns="jabber:client" type="result"/>

2019-11-27 19:19:59 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3374b6ab}

2019-11-27 19:19:59 | [Mutex] received everything.

2019-11-27 19:19:59 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Connector  state changed: connected->disconnecting

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Terminating XMPP Stream

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2959] Connector  state changed: disconnecting->disconnected

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2959] Stream terminated

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2019-11-27 19:19:59 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3bece9cc}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@3fd36a69}, urn:xmpp:sm:3#SM_ACK_ENABLED=Entry{scope=stream, value=false}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7ad1e3f7}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@171f067d}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:19:59 PST 2019}}}}

2019-11-27 19:19:59 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3bece9cc}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@3fd36a69}, urn:xmpp:sm:3#SM_ACK_ENABLED=Entry{scope=stream, value=false}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@7ad1e3f7}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@171f067d}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:19:59 PST 2019}}}}

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4e90da2d

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@57aeaec2

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@38ed0205

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

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:19:59 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2eba2a5d

2019-11-27 19:19:59 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@6633cc15

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

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

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2964] Start TLS

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2966] Proceeding TLS

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2966] Start handshake

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19xa2lwbDMwMTkxLHI9M0hTVFA2dWZGaGhDR1hNT1dPeHg=</auth>

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zSFNUUDZ1ZkZoaENHWE1PV094eDlwVlYwM0wyZVRpM2thaGdYbXdKLHM9eVRPQ3dnYmtWQS85Mmc9PSxpPTQwOTY=</challenge>

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M0hTVFA2dWZGaGhDR1hNT1dPeHg5cFZWMDNMMmVUaTNrYWhnWG13SixwPVpub2JSZXJMWnVVUHlVUGMvaVp6dk1pRW0vOWFCendWcGtBMW5BU0FJcUE9</response>

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1MR1p5NlFWaFJpWjBXeC90K2xYeXpHM3F0TURQbWJZNzVubmxJZllrbnlJPQ==</success>

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@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 xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost >> <iq xmlns="jabber:client" id="hFaj1xkN26uqiZpaAhW9Exc" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost << <iq id="hFaj1xkN26uqiZpaAhW9Exc" to="http-admin__qkipl30191@localhost/993927746-tigase-208" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__qkipl30191@localhost/993927746-tigase-208</jid></bind></iq>

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost/993927746-tigase-208 >> <iq xmlns="jabber:client" id="TD2CwuqfVcEpcFGBk6mJV9t" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost/993927746-tigase-208 << <iq id="TD2CwuqfVcEpcFGBk6mJV9t" to="http-admin__qkipl30191@localhost/993927746-tigase-208" xmlns="jabber:client" type="result"/>

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost/993927746-tigase-208 >> <iq to="localhost" id="RstBEkWk6BDCu5yn6r0s49L" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost/993927746-tigase-208 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost/993927746-tigase-208 << <enabled id="985473dc-2758-4f43-bb14-a58e504675f1" xmlns="urn:xmpp:sm:3" max="60" resume="true" location="d4270859fb27"/>

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost/993927746-tigase-208 >> <iq id="uzMkLU5whGOMzBvbGzBuYrl" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost/993927746-tigase-208 << <iq id="RstBEkWk6BDCu5yn6r0s49L" from="localhost" to="http-admin__qkipl30191@localhost/993927746-tigase-208" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@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-27 19:20:00 | http-admin_ :: http-admin__qkipl30191@localhost/993927746-tigase-208 << <iq id="uzMkLU5whGOMzBvbGzBuYrl" to="http-admin__qkipl30191@localhost/993927746-tigase-208" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2966] Connector  state changed: disconnecting->disconnected

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

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Using XEP-0077 mode!!!!

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

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

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

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

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@36166ebf

2019-11-27 19:20:00 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@38d1960d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@3cee05cf}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@79ec9c36}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c0a7622}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:20:00 PST 2019}}}}

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

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

2019-11-27 19:20:00 | [Mutex] waiting for: [registration]

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@485fe650

2019-11-27 19:20:00 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@38d1960d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@3cee05cf}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@79ec9c36}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c0a7622}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:20:00 PST 2019}}}}

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@45352e9

2019-11-27 19:20:00 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19c36379}

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2970] Start TLS

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2972] Proceeding TLS

2019-11-27 19:20:00 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-27 19:20:00 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 19:20:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2972] Start handshake

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3657bd05

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@18db0f9

2019-11-27 19:20:00 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f577e3b}

2019-11-27 19:20:00 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-27 19:20:00 | http-admin_ :: null >> <iq to="localhost" id="SnaiCwuqfVcEpcFGBk6mJV9" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 19:20:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@bdd34514}

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

2019-11-27 19:20:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1d8d1e03}

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@16b92722

2019-11-27 19:20:00 | http-admin_ :: null >> <iq to="localhost" id="eI96cTfThOLYYeUgVhU4fS1" type="set"><query xmlns="jabber:iq:register"><username>http-admin__djhc0v0192</username><password>http-admin__djhc0v0192</password><email>9b1bd5c1-b8a5-4c73-87fa-f7b2a564cd7b@localhost</email></query></iq>

2019-11-27 19:20:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@bcf9b0d2}

2019-11-27 19:20:00 | http-admin_ :: null << <iq id="eI96cTfThOLYYeUgVhU4fS1" from="localhost" xmlns="jabber:client" type="result"/>

2019-11-27 19:20:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7a5f5774}

2019-11-27 19:20:00 | [Mutex] received everything.

2019-11-27 19:20:00 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Connector  state changed: connected->disconnecting

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Terminating XMPP Stream

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2972] Connector  state changed: disconnecting->disconnected

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2972] Stream terminated

2019-11-27 19:20:00 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19c36379, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f577e3b]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@38d1960d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@3cee05cf}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@79ec9c36}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c0a7622}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:20:00 PST 2019}}}}

2019-11-27 19:20:00 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19c36379, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f577e3b]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@38d1960d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@3cee05cf}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@79ec9c36}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c0a7622}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:20:00 PST 2019}}}}

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5edd48a2

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2b55287c

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@740a9a03

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@74ee9701

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@40424966

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

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

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

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

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

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2977] Start TLS

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2979] Proceeding TLS

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2979] Start handshake

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19kamhjMHYwMTkyLHI9dWJIS0N1QjNhM0I4a0VFRzViVFI=</auth>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11YkhLQ3VCM2EzQjhrRUVHNWJUUjNNQ0pLb0ZEczhZY0NscE1rTVdyLHM9QlJLcGM4eGhoUlA0TlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWJIS0N1QjNhM0I4a0VFRzViVFIzTUNKS29GRHM4WWNDbHBNa01XcixwPWhKc0VXanpSY1Z6Nm8vVXJ1eU9vZzkya0lKZkt6UDRhMC84RWFvYjN5a2M9</response>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1NUUc3bU4zMWQ3RGZHUjU0TExEcUwzdDFTSUZqOWhzN0E3UGUwdjZpNlhNPQ==</success>

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@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 xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost >> <iq xmlns="jabber:client" id="XI79JOSR6tiPM0al9Bn4l9A" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost << <iq id="XI79JOSR6tiPM0al9Bn4l9A" to="http-admin__djhc0v0192@localhost/993927746-tigase-209" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__djhc0v0192@localhost/993927746-tigase-209</jid></bind></iq>

2019-11-27 19:20:00 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost/993927746-tigase-209 >> <iq xmlns="jabber:client" id="1FWFGBk6mJV9tgJV8g1vpjS" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost/993927746-tigase-209 << <iq id="1FWFGBk6mJV9tgJV8g1vpjS" to="http-admin__djhc0v0192@localhost/993927746-tigase-209" xmlns="jabber:client" type="result"/>

2019-11-27 19:20:00 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost/993927746-tigase-209 >> <iq to="localhost" id="XK9dR4oTaBylO4iBFDrcBFC" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost/993927746-tigase-209 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost/993927746-tigase-209 << <enabled id="2b56126d-1722-4b8f-9918-3295e3881c18" xmlns="urn:xmpp:sm:3" max="60" resume="true" location="d4270859fb27"/>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost/993927746-tigase-209 >> <iq id="KMdesphXp4h02maMXl2kLU5" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@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-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost/993927746-tigase-209 << <iq id="XK9dR4oTaBylO4iBFDrcBFC" from="localhost" to="http-admin__djhc0v0192@localhost/993927746-tigase-209" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost/993927746-tigase-209 << <iq id="KMdesphXp4h02maMXl2kLU5" to="http-admin__djhc0v0192@localhost/993927746-tigase-209" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost/993927746-tigase-209 >> <message to="http-admin__qkipl30191@localhost" id="uGTydOT8v8IAbPX5ubPWSfX"><body>Test message 1</body></message>

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

2019-11-27 19:20:00 | http-admin_ :: http-admin__djhc0v0192@localhost/993927746-tigase-209 >> <message to="http-admin__qkipl30191@localhost" id="glQHR7JIzAcGO4xvmY3ufQV"><body>Test message 2</body></message>

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2979] Connector  state changed: connected->disconnected

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2979] Stream terminated

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:02 | 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.421s
2019-11-27 19:20:02 |

2019-11-27 19:20:02 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-27 19:20:02 | ------------------------------------

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Using XEP-0077 mode!!!!

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1305b982

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

2019-11-27 19:20:02 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1dc25592}, 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@19fdd2f2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5cff5fa9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6288341d}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:20:02 PST 2019}}}}

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

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

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

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

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

2019-11-27 19:20:02 | [Mutex] waiting for: [registration]

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6de9831b

2019-11-27 19:20:02 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1dc25592}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@19fdd2f2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5cff5fa9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6288341d}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:20:02 PST 2019}}}}

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@1a74b616

2019-11-27 19:20:02 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3cd0a0e6}

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2983] Start TLS

2019-11-27 19:20:02 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-27 19:20:02 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 19:20:02 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2985] Proceeding TLS

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2985] Start handshake

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1f5b43bd

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3e0bea16

2019-11-27 19:20:02 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1703fc7}

2019-11-27 19:20:02 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-27 19:20:02 | http-admin_ :: null >> <iq to="localhost" id="ADCScy7HHzs7HGmdTbRY5Cg" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 19:20:02 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@29e716aa}

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

2019-11-27 19:20:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@389e789f}

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@7d1d929a

2019-11-27 19:20:02 | http-admin_ :: null >> <iq to="localhost" id="LHM4DJRdGvsWaM0pfQWZmZk" type="set"><query xmlns="jabber:iq:register"><username>http-admin__rh1xz80193</username><password>http-admin__rh1xz80193</password><email>7c4af7cb-ed2f-4e05-ae2b-e981c5968d7e@localhost</email></query></iq>

2019-11-27 19:20:02 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f4a1ed4e}

2019-11-27 19:20:02 | http-admin_ :: null << <iq id="LHM4DJRdGvsWaM0pfQWZmZk" from="localhost" xmlns="jabber:client" type="result"/>

2019-11-27 19:20:02 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1ca78c75}

2019-11-27 19:20:02 | [Mutex] received everything.

2019-11-27 19:20:02 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2985] Connector  state changed: disconnecting->disconnected

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2985] Stream terminated

2019-11-27 19:20:02 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3cd0a0e6, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1703fc7]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1dc25592}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@19fdd2f2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5cff5fa9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6288341d}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:20:02 PST 2019}}}}

2019-11-27 19:20:02 | 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;@7e4e2696}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3cd0a0e6, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1703fc7]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1dc25592}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6ceae451}, 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@19fdd2f2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5cff5fa9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6288341d}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Wed Nov 27 19:20:02 PST 2019}}}}

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1ca90621

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@5738cfab

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@46a00e94

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@6644e611

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@32087cf6

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=1] Connector  state changed: null->connecting

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=1] DNS entry stored in session object: localhost:5222

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=1] Preparing connection to [localhost:5222]

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=1] Connector  state changed: connecting->connected

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=1] Whitespace ping period is setted to nullms

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=2990] Start TLS

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=2992] Proceeding TLS

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=2992] Start handshake

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19yaDF4ejgwMTkzLHI9RTJoYmZOcGxhQmJjTzI3bEhOdXY=</auth>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FMmhiZk5wbGFCYmNPMjdsSE51dmVXTnpmc25oZFV3N1BEaUdOcUF0LHM9bDhmcm5aRHFRWUlSNGc9PSxpPTQwOTY=</challenge>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RTJoYmZOcGxhQmJjTzI3bEhOdXZlV056ZnNuaGRVdzdQRGlHTnFBdCxwPXhXai9jMnkxN2NKTlBZR05GUGgvNzQvcitTamsxcUhFRi9wajBqbTB5Rkk9</response>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1scHFUK3hPOGh0SlZzbXgvdzUrYzRBbGVPcnd5Y0dqcHk4RXpnbDkyRUxBPQ==</success>

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@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 xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost >> <iq xmlns="jabber:client" id="dDy5sUj5zDwbOEACGLXgMFI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost/993927746-tigase-210 << <iq id="dDy5sUj5zDwbOEACGLXgMFI" to="http-admin__rh1xz80193@localhost/993927746-tigase-210" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__rh1xz80193@localhost/993927746-tigase-210</jid></bind></iq>

2019-11-27 19:20:02 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost/993927746-tigase-210 >> <iq xmlns="jabber:client" id="ILUxxmIVj1xkN26uqiZpaAh" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost/993927746-tigase-210 << <iq id="ILUxxmIVj1xkN26uqiZpaAh" to="http-admin__rh1xz80193@localhost/993927746-tigase-210" xmlns="jabber:client" type="result"/>

2019-11-27 19:20:02 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost/993927746-tigase-210 >> <iq to="localhost" id="yJMq5i2etp7p8tp6cTfThOL" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost/993927746-tigase-210 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost/993927746-tigase-210 << <enabled id="92dc18f6-7e40-4bc1-ae0c-f2b0ae2225ef" xmlns="urn:xmpp:sm:3" max="60" resume="true" location="d4270859fb27"/>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost/993927746-tigase-210 >> <iq id="WVkCDHKKBAreHwu8h1lR2h1" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@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-27 19:20:02 | http-admin_ :: http-admin__rh1xz80193@localhost/993927746-tigase-210 << <iq id="yJMq5i2etp7p8tp6cTfThOL" from="localhost" to="http-admin__rh1xz80193@localhost/993927746-tigase-210" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-27 19:20:03 | http-admin_ :: http-admin__rh1xz80193@localhost/993927746-tigase-210 << <iq id="WVkCDHKKBAreHwu8h1lR2h1" to="http-admin__rh1xz80193@localhost/993927746-tigase-210" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:20:03 | http-admin_ :: http-admin__rh1xz80193@localhost/993927746-tigase-210 << <presence from="http-admin__rh1xz80193@localhost/993927746-tigase-210" to="http-admin__rh1xz80193@localhost" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></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.427s
2019-11-27 19:20:03 |

2019-11-27 19:20:03 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-27 19:20:03 | ------------------------------------

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=1] Using XEP-0077 mode!!!!

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=1] Connector  state changed: null->connecting

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@17284170

2019-11-27 19:20:03 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, 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=Wed Nov 27 19:20:03 PST 2019}}}}

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=1] DNS entry stored in session object: localhost:5222

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=1] Preparing connection to [localhost:5222]

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=1] Connector  state changed: connecting->connected

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=1] Whitespace ping period is setted to nullms

2019-11-27 19:20:03 | [Mutex] waiting for: [registration]

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@69c05ab1

2019-11-27 19:20:03 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@7e4e2696}, 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@6ceae451}, 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=Wed Nov 27 19:20:03 PST 2019}}}}

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@75dceda3

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=2995] Start TLS

2019-11-27 19:20:03 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-27 19:20:03 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@38fd5891}

2019-11-27 19:20:03 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 19:20:03 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=2997] Proceeding TLS

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=2997] Start handshake

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1705fe1d

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7cfb3b9e

2019-11-27 19:20:03 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6ed86057}

2019-11-27 19:20:03 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-11-27 19:20:03 | http-admin_ :: null >> <iq to="localhost" id="WWlEHP0gDEzudyygxxnVaxx" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 19:20:03 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@a4f1e2c6}

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

2019-11-27 19:20:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3cb384cd}

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@47e6050

2019-11-27 19:20:03 | http-admin_ :: null >> <iq to="localhost" id="lLMdSMQ8IP5wiHMP0fCGw3z" type="set"><query xmlns="jabber:iq:register"><username>http-admin__o9kdwn0194</username><password>http-admin__o9kdwn0194</password><email>078ffd8e-9f65-4fba-bffc-28659d7aee87@localhost</email></query></iq>

2019-11-27 19:20:03 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@82cf1174}

2019-11-27 19:20:03 | http-admin_ :: null << <iq id="lLMdSMQ8IP5wiHMP0fCGw3z" from="localhost" xmlns="jabber:client" type="result"/>

2019-11-27 19:20:03 | [Mutex] received everything.

2019-11-27 19:20:03 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 19:20:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@217c8c8a}

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=1] Connector  state changed: connected->disconnecting

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=1] Terminating XMPP Stream

2019-11-27 19:20:03 | 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;@7e4e2696}, 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@6ceae451}, 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@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=Wed Nov 27 19:20:03 PST 2019}}}}

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=2997] Connector  state changed: disconnecting->disconnected

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=2997] Stream terminated

2019-11-27 19:20:03 | 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;@7e4e2696}, 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@6ceae451}, 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=Wed Nov 27 19:20:03 PST 2019}}}}

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@c0b8a2a

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2c3ee28a

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5bb57bbd

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=1] Connector  state changed: null->connecting

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1e68a49d

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@4ee227a0

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=1] DNS entry stored in session object: localhost:5222

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=1] Preparing connection to [localhost:5222]

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=1] Opening connection to localhost/127.0.0.1:5222

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=1] Connector  state changed: connecting->connected

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=1] Whitespace ping period is setted to nullms

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=3002] Start TLS

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=3004] Proceeding TLS

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=3004] Start handshake

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19vOWtkd24wMTk0LHI9WlA3aG9NdHZndlNJYk5GR093RzE=</auth>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aUDdob010dmd2U0liTkZHT3dHMURPVzRmQlV6YUlER2U0eEdieDgzLHM9eDAwNjlLamptdW9lVlE9PSxpPTQwOTY=</challenge>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WlA3aG9NdHZndlNJYk5GR093RzFET1c0ZkJVemFJREdlNHhHYng4MyxwPXlPak5aMEtob2pVTlh4RXBtZldseXh2SkFJaXIxM0tkdnpJQXNodnY0eTA9</response>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj16QUJvdVhkRWpjQmFWaXRra2dVLzQvd0NNeGlPVzJwQmtBR29ESzRCN1VRPQ==</success>

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@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 xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="TbICgu8ra7zV0VOWQA2Ec+/yqKw="/></features>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost >> <iq xmlns="jabber:client" id="5EpMIrlZ9CrlYWndP9yfWU6" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost << <iq id="5EpMIrlZ9CrlYWndP9yfWU6" to="http-admin__o9kdwn0194@localhost/993927746-tigase-211" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__o9kdwn0194@localhost/993927746-tigase-211</jid></bind></iq>

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost/993927746-tigase-211 >> <iq xmlns="jabber:client" id="6ZosVjV1mVjUO7HN5qZqS2w" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost/993927746-tigase-211 << <iq id="6ZosVjV1mVjUO7HN5qZqS2w" to="http-admin__o9kdwn0194@localhost/993927746-tigase-211" xmlns="jabber:client" type="result"/>

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost/993927746-tigase-211 >> <iq to="localhost" id="K1sIql9HT2dSMQ8IP5wiHMP" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost/993927746-tigase-211 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost/993927746-tigase-211 << <enabled id="8cc42cb8-c936-40ea-ad1d-28532aa95976" xmlns="urn:xmpp:sm:3" max="60" resume="true" location="d4270859fb27"/>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost/993927746-tigase-211 >> <iq id="oBa8IS9JOSR6tiPM0al9Bn4" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost/993927746-tigase-211 << <iq id="K1sIql9HT2dSMQ8IP5wiHMP" from="localhost" to="http-admin__o9kdwn0194@localhost/993927746-tigase-211" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component"/><identity type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@localhost/993927746-tigase-211 << <iq id="oBa8IS9JOSR6tiPM0al9Bn4" to="http-admin__o9kdwn0194@localhost/993927746-tigase-211" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 19:20:03 | http-admin_ :: http-admin__o9kdwn0194@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-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=1] Connector  state changed: connected->disconnecting

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=1] Terminating XMPP Stream

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-27 19:20:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=3004] Connector  state changed: disconnecting->disconnected

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2019-11-27 19:20:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

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