UI: Web Admin UI - #2955

Test duration: 4.977s

Failed Tests
tigase.tests.http.TestAdminUI
testAddUser 0.011s
2019-11-22 19:15:08 |

2019-11-22 19:15:08 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-22 19:15:08 | ------------------------------------

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

2019-11-22 19:15:08 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-22 19:15:08 | ------------------------------------

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

2019-11-22 19:15:08 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-22 19:15:08 | ------------------------------------

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.207s
2019-11-22 19:15:08 |

2019-11-22 19:15:08 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-22 19:15:08 | ------------------------------------

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@c86a970

2019-11-22 19:15:08 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2415690}, 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@67ec200}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@437c5cab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a88a09d}, 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=Fri Nov 22 19:15:08 PST 2019}}}}

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

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

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

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

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

2019-11-22 19:15:08 | [Mutex] waiting for: [registration]

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@72f59c8a

2019-11-22 19:15:08 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2415690}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@67ec200}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@437c5cab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a88a09d}, 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=Fri Nov 22 19:15:08 PST 2019}}}}

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2eb3e16

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2939] Start TLS

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

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

2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2353a3e4}

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2941] Proceeding TLS

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2941] Start handshake

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1c60635b

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@42afad91

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

2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19ef305c}

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

2019-11-22 19:15:08 | http-admin_ :: null >> <iq to="localhost" id="Qec8yt5dLJAfveVTXj1wdVh" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@46de33cd}

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

2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@271dfc06}

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@38f82905

2019-11-22 19:15:08 | http-admin_ :: null >> <iq to="localhost" id="WlvKCjDurV1rh2fZpWhGnLR" type="set"><query xmlns="jabber:iq:register"><username>http-admin__u86ty70187</username><password>http-admin__u86ty70187</password><email>f15c04ef-2abc-4dc9-9070-f38f19c25558@localhost</email></query></iq>

2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@32494350}

2019-11-22 19:15:08 | http-admin_ :: null << <iq id="WlvKCjDurV1rh2fZpWhGnLR" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@704c8ae}

2019-11-22 19:15:08 | [Mutex] received everything.

2019-11-22 19:15:08 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2941] Connector  state changed: disconnecting->disconnected

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2941] Stream terminated

2019-11-22 19:15:08 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2353a3e4, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19ef305c]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2415690}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@67ec200}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@437c5cab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a88a09d}, 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=Fri Nov 22 19:15:08 PST 2019}}}}

2019-11-22 19:15:08 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2353a3e4, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19ef305c]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2415690}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@67ec200}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@437c5cab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a88a09d}, 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=Fri Nov 22 19:15:08 PST 2019}}}}

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@670975c2

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2fbc48e9

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@56f5fc1a

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@77951fd2

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5b1ec387

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.867s
2019-11-22 19:15:08 |

2019-11-22 19:15:08 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-22 19:15:08 | ------------------------------------

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6374d705

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

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

2019-11-22 19:15:08 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6db3251b}, 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@698cbc75}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2c8e2f20}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6987094b}, 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=Fri Nov 22 19:15:08 PST 2019}}}}

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

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

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

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

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

2019-11-22 19:15:08 | [Mutex] waiting for: [registration]

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1d68629d

2019-11-22 19:15:08 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6db3251b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@698cbc75}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2c8e2f20}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6987094b}, 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=Fri Nov 22 19:15:08 PST 2019}}}}

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@118b1a51

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

2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ca1d06f}

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2946] Start TLS

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

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2948] Proceeding TLS

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2948] Start handshake

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1d3d45e1

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@431fb051

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

2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@a8f73f1}

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

2019-11-22 19:15:08 | http-admin_ :: null >> <iq to="localhost" id="baVnLR3uqbMNNS7nNV3ex5o" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6bda709d}

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

2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@48efe867}

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3f0aaed6

2019-11-22 19:15:08 | http-admin_ :: null >> <iq to="localhost" id="hvUFKJFCBlJNNIv1gZ1dP3A" type="set"><query xmlns="jabber:iq:register"><username>http-admin__mkg87n0188</username><password>http-admin__mkg87n0188</password><email>217ba8a4-2a8e-49ff-8ea4-7dbb95d16bca@localhost</email></query></iq>

2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@dd2e161c}

2019-11-22 19:15:08 | http-admin_ :: null << <iq id="hvUFKJFCBlJNNIv1gZ1dP3A" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1290c5e}

2019-11-22 19:15:08 | [Mutex] received everything.

2019-11-22 19:15:08 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-22 19:15:08 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ca1d06f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@a8f73f1]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6db3251b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@698cbc75}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2c8e2f20}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6987094b}, 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=Fri Nov 22 19:15:08 PST 2019}}}}

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2948] Connector  state changed: disconnecting->disconnected

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2948] Stream terminated

2019-11-22 19:15:08 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ca1d06f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@a8f73f1]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6db3251b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@698cbc75}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2c8e2f20}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6987094b}, 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=Fri Nov 22 19:15:08 PST 2019}}}}

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@70c8f771

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@47d385df

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2dc5ffed

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@64475df7

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@53035d71

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2953] Start TLS

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2955] Proceeding TLS

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2955] Start handshake

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19ta2c4N24wMTg4LHI9UzRXN3g2Q2hycTJ4NjZCdDlwWkk=</auth>

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TNFc3eDZDaHJxMng2NkJ0OXBaSUNGSkJhWUpoQWZNT1MxY2g1a295LHM9WGFVcy9tdURkYnlnUVE9PSxpPTQwOTY=</challenge>

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UzRXN3g2Q2hycTJ4NjZCdDlwWklDRkpCYVlKaEFmTU9TMWNoNWtveSxwPWtKaUpqcktUL09kcWZDVkRzN1JPZ1F2WlhURHRkU1owVzdRZlpQbzlLQkk9</response>

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1mZDVBWWRIUUdqaC85VC9BQkNaU3YwaXBxSFVLUHlzMERQVEtCWGVOQzM0PQ==</success>

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost >> <iq xmlns="jabber:client" id="nrG15vdybnYpRTbL0bR9qfC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost << <iq id="nrG15vdybnYpRTbL0bR9qfC" type="result" to="http-admin__mkg87n0188@localhost/993927746-tigase-209" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__mkg87n0188@localhost/993927746-tigase-209</jid></bind></iq>

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 >> <iq xmlns="jabber:client" id="jvQr5shHrdDoRJGPHzxtq1x" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 << <iq id="jvQr5shHrdDoRJGPHzxtq1x" type="result" to="http-admin__mkg87n0188@localhost/993927746-tigase-209" xmlns="jabber:client"/>

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 >> <iq to="localhost" id="BA3N5Bk3etXfP2wnazlYjLz" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 << <enabled id="d2ecea1e-6da9-4d42-abf1-60d061b85710" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/>

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 >> <iq id="Ug3FFxctX8JvbLVkP9JAzgx" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 << <iq id="Ug3FFxctX8JvbLVkP9JAzgx" type="result" to="http-admin__mkg87n0188@localhost/993927746-tigase-209" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2955] Connector  state changed: disconnecting->disconnected

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@549304d2

2019-11-22 19:15:08 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5a54f030}, 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@5e6b6fa2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1b69fa0b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5710c820}, 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=Fri Nov 22 19:15:08 PST 2019}}}}

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

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

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2ab86782

2019-11-22 19:15:08 | [Mutex] waiting for: [registration]

2019-11-22 19:15:08 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5a54f030}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@5e6b6fa2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1b69fa0b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5710c820}, 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=Fri Nov 22 19:15:08 PST 2019}}}}

2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2f2b0b08

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

2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7b460544}

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2959] Start TLS

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

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

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

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2961] Proceeding TLS

2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2961] Start handshake

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2ac693c4

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@43ab7569

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

2019-11-22 19:15:09 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@342f455f}

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

2019-11-22 19:15:09 | http-admin_ :: null >> <iq to="localhost" id="SqvTVT7r05bADjNZneDLX2t" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 19:15:09 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@330a1378}

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

2019-11-22 19:15:09 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7f081abb}

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@61ceee2d

2019-11-22 19:15:09 | http-admin_ :: null >> <iq to="localhost" id="gxOAvq5n2r15vdybnYpRTbL" type="set"><query xmlns="jabber:iq:register"><username>http-admin__53ewir0189</username><password>http-admin__53ewir0189</password><email>60b6cd12-8b04-4f31-9734-b861da2b39db@localhost</email></query></iq>

2019-11-22 19:15:09 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@661889de}

2019-11-22 19:15:09 | http-admin_ :: null << <iq id="gxOAvq5n2r15vdybnYpRTbL" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-22 19:15:09 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@79d6df40}

2019-11-22 19:15:09 | [Mutex] received everything.

2019-11-22 19:15:09 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-22 19:15:09 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7b460544, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@342f455f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5a54f030}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@5e6b6fa2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1b69fa0b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5710c820}, 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=Fri Nov 22 19:15:09 PST 2019}}}}

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2961] Connector  state changed: disconnecting->disconnected

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2961] Stream terminated

2019-11-22 19:15:09 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7b460544, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@342f455f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5a54f030}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@5e6b6fa2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1b69fa0b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5710c820}, 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=Fri Nov 22 19:15:09 PST 2019}}}}

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@371d6898

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@87f6102

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1ed659a6

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@5135a9e3

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@d3042f5

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

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2966] Start TLS

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2968] Proceeding TLS

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2968] Start handshake

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX181M2V3aXIwMTg5LHI9dFRtcnBMeHFUN2tlUndQRDE1elc=</auth>

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10VG1ycEx4cVQ3a2VSd1BEMTV6V0J5TndsNTZQOEMxVEFaa21jQWFQLHM9RUZZa0ZnQ0pnTmdlMVE9PSxpPTQwOTY=</challenge>

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFRtcnBMeHFUN2tlUndQRDE1eldCeU53bDU2UDhDMVRBWmttY0FhUCxwPTZjbkVxY1dGejRxeUlGM1RLOWF0aFMxenJDUU9kM3FCaGE5ZlhXc25pWGc9</response>

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1XTXYxTjlFSUt3dklCbkFrUm1BS2xhUmdGVU9CdmsyVUFXTDZtb0hXSmlNPQ==</success>

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost >> <iq xmlns="jabber:client" id="4zSKFP5iZ6drdLUgR8vdINJ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost << <iq id="4zSKFP5iZ6drdLUgR8vdINJ" type="result" to="http-admin__53ewir0189@localhost/993927746-tigase-210" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__53ewir0189@localhost/993927746-tigase-210</jid></bind></iq>

2019-11-22 19:15:09 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <iq xmlns="jabber:client" id="StyZ7hTZ6hzmbpZn9MJXlO1" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 << <iq id="StyZ7hTZ6hzmbpZn9MJXlO1" type="result" to="http-admin__53ewir0189@localhost/993927746-tigase-210" xmlns="jabber:client"/>

2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <iq to="localhost" id="krqzqdzbHBkJtaNDrhXoXpf" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 << <enabled id="b031e3df-1280-4d28-a707-9805a41ce390" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/>

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <iq id="NF4Zo1fMVZ1nX29jQ9lR7DK" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@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-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 << <iq id="NF4Zo1fMVZ1nX29jQ9lR7DK" type="result" to="http-admin__53ewir0189@localhost/993927746-tigase-210" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <message to="http-admin__mkg87n0188@localhost" id="EF2IPMz9DBACzylT4v9l1fC"><body>Test message 1</body></message>

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

2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <message to="http-admin__mkg87n0188@localhost" id="zEXP8rnbunSLxp9GOXkTZgT"><body>Test message 2</body></message>

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2968] Connector  state changed: connected->disconnected

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2968] Stream terminated

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:11 | 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.475s
2019-11-22 19:15:11 |

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

2019-11-22 19:15:11 | ------------------------------------

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@167be285

2019-11-22 19:15:11 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18bc1e3a}, 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@1c8389f5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59811401}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1027aa7e}, 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=Fri Nov 22 19:15:11 PST 2019}}}}

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

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

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

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

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

2019-11-22 19:15:11 | [Mutex] waiting for: [registration]

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

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@68122b8e

2019-11-22 19:15:11 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18bc1e3a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@1c8389f5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59811401}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1027aa7e}, 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=Fri Nov 22 19:15:11 PST 2019}}}}

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@685ecb58

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

2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39aeeb4e}

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2972] Start TLS

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

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2974] Proceeding TLS

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2974] Start handshake

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

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@14f7c25f

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@6d40d514

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

2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@735ac7ef}

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

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

2019-11-22 19:15:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5825176a}

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

2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3de0b651}

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@17af7e88

2019-11-22 19:15:11 | http-admin_ :: null >> <iq to="localhost" id="xmXBBBGxzzgVYXVbHM0l6r5" type="set"><query xmlns="jabber:iq:register"><username>http-admin__f9ggsu0190</username><password>http-admin__f9ggsu0190</password><email>0d7b6582-9b0f-49a0-a917-c01951cdb522@localhost</email></query></iq>

2019-11-22 19:15:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4d650ab0}

2019-11-22 19:15:11 | http-admin_ :: null << <iq id="xmXBBBGxzzgVYXVbHM0l6r5" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7cace11c}

2019-11-22 19:15:11 | [Mutex] received everything.

2019-11-22 19:15:11 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2974] Connector  state changed: disconnecting->disconnected

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2974] Stream terminated

2019-11-22 19:15:11 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39aeeb4e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@735ac7ef]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18bc1e3a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@1c8389f5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59811401}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1027aa7e}, 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=Fri Nov 22 19:15:11 PST 2019}}}}

2019-11-22 19:15:11 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39aeeb4e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@735ac7ef]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18bc1e3a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@1c8389f5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59811401}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1027aa7e}, 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=Fri Nov 22 19:15:11 PST 2019}}}}

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@59ec24d9

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6106538b

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@d313a1d

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@160e9ea6

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2e7caa52

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2979] Start TLS

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2981] Proceeding TLS

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2981] Start handshake

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

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19mOWdnc3UwMTkwLHI9c0twemJyWUVweGJxODUwejdsaEU=</auth>

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zS3B6YnJZRXB4YnE4NTB6N2xoRXNrVzBTVzhDR2VOVlVmaXVwVGU3LHM9cng5NUpzQ1NSSC8xVlE9PSxpPTQwOTY=</challenge>

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c0twemJyWUVweGJxODUwejdsaEVza1cwU1c4Q0dlTlZVZml1cFRlNyxwPVI1TG1aQVludTBqWThtLzJLZ3AxMVZkMFduMzJSd21CTzNVak10VU0vOEk9</response>

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1IS3hyWXd4Ulc5K2VZakVqOElQSjdsUll4S1RQYXVMU1QvSUt0NDBldXpFPQ==</success>

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

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost >> <iq xmlns="jabber:client" id="ssd13k7hJR7IBHPMX25bHJQ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost << <iq id="ssd13k7hJR7IBHPMX25bHJQ" type="result" to="http-admin__f9ggsu0190@localhost/993927746-tigase-211" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__f9ggsu0190@localhost/993927746-tigase-211</jid></bind></iq>

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 >> <iq xmlns="jabber:client" id="FtenSLxp9GOXkTZgTVT7r05" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 << <iq id="FtenSLxp9GOXkTZgTVT7r05" type="result" to="http-admin__f9ggsu0190@localhost/993927746-tigase-211" xmlns="jabber:client"/>

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 >> <iq to="localhost" id="cnUl1n8ILW7raHx7zlOHp2x" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 >> <iq id="jN81fMVZ1nX29jQ9lR7DKFP" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 << <enabled id="b9a9d42c-bb05-4cd1-9cad-a6f1fba10579" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/>

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

2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 << <iq id="jN81fMVZ1nX29jQ9lR7DKFP" type="result" to="http-admin__f9ggsu0190@localhost/993927746-tigase-211" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

2019-11-22 19:15:11 | ------------------------------------

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@13e017bb

2019-11-22 19:15:11 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1d27ebb7}, 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@19187ccb}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5c1ae18c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f54687b}, 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=Fri Nov 22 19:15:11 PST 2019}}}}

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

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

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

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

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

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

2019-11-22 19:15:11 | [Mutex] waiting for: [registration]

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6d8c5875

2019-11-22 19:15:11 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1d27ebb7}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@19187ccb}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5c1ae18c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f54687b}, 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=Fri Nov 22 19:15:11 PST 2019}}}}

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@37288f2b

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

2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3c351ec3}

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2984] Start TLS

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

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

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

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2986] Proceeding TLS

2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2986] Start handshake

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

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@504ebe8e

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5f0e0b02

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

2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2c2c861f}

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

2019-11-22 19:15:11 | http-admin_ :: null >> <iq to="localhost" id="2zqLVkP9JAzgx5vl4Avq5n2" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 19:15:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3af053cf}

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

2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@387b465f}

2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1de42510

2019-11-22 19:15:11 | http-admin_ :: null >> <iq to="localhost" id="ps3X7mNBqjFvpdUZtnS9qRJ" type="set"><query xmlns="jabber:iq:register"><username>http-admin__8rgwty0191</username><password>http-admin__8rgwty0191</password><email>24c0cf95-81ee-4eef-aa16-d2465c086f5e@localhost</email></query></iq>

2019-11-22 19:15:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1c25ae35}

2019-11-22 19:15:12 | http-admin_ :: null << <iq id="ps3X7mNBqjFvpdUZtnS9qRJ" type="result" from="localhost" xmlns="jabber:client"/>

2019-11-22 19:15:12 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@329d7bb5}

2019-11-22 19:15:12 | [Mutex] received everything.

2019-11-22 19:15:12 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-22 19:15:12 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3c351ec3, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2c2c861f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1d27ebb7}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@19187ccb}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5c1ae18c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f54687b}, 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=Fri Nov 22 19:15:12 PST 2019}}}}

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2986] Connector  state changed: disconnecting->disconnected

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2986] Stream terminated

2019-11-22 19:15:12 | 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;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3c351ec3, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2c2c861f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1d27ebb7}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, 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@19187ccb}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5c1ae18c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f54687b}, 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=Fri Nov 22 19:15:12 PST 2019}}}}

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7ac90f87

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@18e2e73f

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

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

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@24929d96

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

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

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

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7d8b0a62

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@4f8c8763

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

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

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

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2991] Start TLS

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

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2993] Proceeding TLS

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2993] Start handshake

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX184cmd3dHkwMTkxLHI9Z2Z4MDVsZjFhdmdIbmRpaVg4RWM=</auth>

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nZngwNWxmMWF2Z0huZGlpWDhFY3NYb0dFZ1pER1Fza3RheW9VaGQyLHM9QnVIUTdnOGNBOXUyT2c9PSxpPTQwOTY=</challenge>

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z2Z4MDVsZjFhdmdIbmRpaVg4RWNzWG9HRWdaREdRc2t0YXlvVWhkMixwPXU3Z0h4eCtRMFI1NWQ0UFRPZG5GTmNuL1ZNSmlicnc3eDZ6YXdPUHIwRzA9</response>

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1qcUNIRVlvbEp6Qm1HdGE1YjFaTmk5bG94YktQSGJjWTQzYjRlUHNmSlJzPQ==</success>

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost >> <iq xmlns="jabber:client" id="UzmhTZ6hzmbpZn9MJXlO1al" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost << <iq id="UzmhTZ6hzmbpZn9MJXlO1al" type="result" to="http-admin__8rgwty0191@localhost/993927746-tigase-212" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__8rgwty0191@localhost/993927746-tigase-212</jid></bind></iq>

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 >> <iq xmlns="jabber:client" id="ESf8FsVR3rgYhYbzqdzbHBk" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 << <iq id="ESf8FsVR3rgYhYbzqdzbHBk" type="result" to="http-admin__8rgwty0191@localhost/993927746-tigase-212" xmlns="jabber:client"/>

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 >> <iq to="localhost" id="Jt0R3uqbMNNS7nNV3ex5ofx" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 << <enabled id="b7898bbc-a9fb-4ab6-ae2a-5321de173cdd" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/>

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 >> <iq id="nQ5PHJFsZZcRLHNZs5FLEHw" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 << <iq id="nQ5PHJFsZZcRLHNZs5FLEHw" type="result" to="http-admin__8rgwty0191@localhost/993927746-tigase-212" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 << <presence from="http-admin__8rgwty0191@localhost/993927746-tigase-212" to="http-admin__8rgwty0191@localhost" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps"/></presence>

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2993] Connector  state changed: disconnecting->disconnected

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2993] Stream terminated

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

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