UI: Web Admin UI - #2955

Test duration: 5.079s

Failed Tests
tigase.tests.http.TestAdminUI
testAddUser 0.020s
2019-11-24 19:13:00 |

2019-11-24 19:13:00 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-24 19:13:00 | ------------------------------------

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

2019-11-24 19:13:00 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-24 19:13:00 | ------------------------------------

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-24 19:13:00 |

2019-11-24 19:13:00 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-24 19:13:00 | ------------------------------------

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.173s
2019-11-24 19:13:00 |

2019-11-24 19:13:00 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-24 19:13:00 | ------------------------------------

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

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

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6af416ac

2019-11-24 19:13:00 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6433e582}, 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@600c7ddc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@250eefb9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6f85ccc2}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:00 PST 2019}}}}

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

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

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

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

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

2019-11-24 19:13:00 | [Mutex] waiting for: [registration]

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

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@14e12b45

2019-11-24 19:13:00 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6433e582}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@600c7ddc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@250eefb9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6f85ccc2}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:00 PST 2019}}}}

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@17805698

2019-11-24 19:13:00 | 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-24 19:13:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@452110f6}

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2948] Start TLS

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

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

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2950] Proceeding TLS

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2950] Start handshake

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@483274c

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

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@19259f9a

2019-11-24 19:13:00 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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-24 19:13:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c843eb0}

2019-11-24 19:13:00 | 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-24 19:13:00 | http-admin_ :: null >> <iq to="localhost" id="FhjbIRV4kM09Atq3qSNDq5C" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 19:13:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ef9c6862}

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

2019-11-24 19:13:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@416f2976}

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5ccbcf50

2019-11-24 19:13:00 | http-admin_ :: null >> <iq to="localhost" id="csPnY8oeBuh2hSMBfExw3n5" type="set"><query xmlns="jabber:iq:register"><username>http-admin__twsaw0190</username><password>http-admin__twsaw0190</password><email>769bc8fc-5278-418d-8cd6-8cf7b9d510a1@localhost</email></query></iq>

2019-11-24 19:13:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@846d51ab}

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

2019-11-24 19:13:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6927421c}

2019-11-24 19:13:00 | [Mutex] received everything.

2019-11-24 19:13:00 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-24 19:13:00 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@452110f6, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c843eb0]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6433e582}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@600c7ddc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@250eefb9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6f85ccc2}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:00 PST 2019}}}}

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2950] Connector  state changed: disconnecting->disconnected

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2950] Stream terminated

2019-11-24 19:13:00 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@452110f6, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@c843eb0]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6433e582}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@600c7ddc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@250eefb9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6f85ccc2}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:00 PST 2019}}}}

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@44fb9036

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7c672546

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

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

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

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7e54c4d5

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

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

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2db05ea1

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@35521101

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.941s
2019-11-24 19:13:00 |

2019-11-24 19:13:00 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-24 19:13:00 | ------------------------------------

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

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

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6987c34d

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

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

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

2019-11-24 19:13:00 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6740200d}, 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@637fa83d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@267d2a36}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7137181f}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:00 PST 2019}}}}

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

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

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

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

2019-11-24 19:13:00 | [Mutex] waiting for: [registration]

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

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@17110e7c

2019-11-24 19:13:00 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6740200d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@637fa83d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@267d2a36}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7137181f}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:00 PST 2019}}}}

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@9b162e3

2019-11-24 19:13:00 | 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-24 19:13:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4652d579}

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2955] Start TLS

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

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

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2957] Proceeding TLS

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2957] Start handshake

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

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@fecda4c

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@10914723

2019-11-24 19:13:00 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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-24 19:13:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@12b589a8}

2019-11-24 19:13:00 | 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-24 19:13:00 | http-admin_ :: null >> <iq to="localhost" id="Jgb6oUgFCxyjWURLGBEjT7g" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 19:13:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1dab2cf8}

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

2019-11-24 19:13:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@421c6f9a}

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@2bcbe32f

2019-11-24 19:13:00 | http-admin_ :: null >> <iq to="localhost" id="Xe3RalXfwnSXZiW8x6yxhMK" type="set"><query xmlns="jabber:iq:register"><username>http-admin__p7ly3g0191</username><password>http-admin__p7ly3g0191</password><email>df70c72c-5dd4-44df-acde-914100958627@localhost</email></query></iq>

2019-11-24 19:13:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e0715be6}

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

2019-11-24 19:13:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3179012a}

2019-11-24 19:13:00 | [Mutex] received everything.

2019-11-24 19:13:00 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-24 19:13:00 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4652d579, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@12b589a8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6740200d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@637fa83d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@267d2a36}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7137181f}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:00 PST 2019}}}}

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2957] Connector  state changed: disconnecting->disconnected

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2957] Stream terminated

2019-11-24 19:13:00 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4652d579, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@12b589a8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6740200d}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@637fa83d}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@267d2a36}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7137181f}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:00 PST 2019}}}}

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@f3f2664

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2efef8a6

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

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

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

2019-11-24 19:13:00 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5ad8a4cd

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

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

2019-11-24 19:13:00 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

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

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@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-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2962] Start TLS

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2964] Proceeding TLS

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2964] Start handshake

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@23d18eed

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@552b80f5

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@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-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19wN2x5M2cwMTkxLHI9VTVGOWJUR3ZYN1JmdHJESXJCSDM=</auth>

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VNUY5YlRHdlg3UmZ0ckRJckJIM0JLSFFPdlBpYzZOMmVOVGtqZ3hELHM9b0k3L1hldWZkNUlReVE9PSxpPTQwOTY=</challenge>

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VTVGOWJUR3ZYN1JmdHJESXJCSDNCS0hRT3ZQaWM2TjJlTlRramd4RCxwPXFsMUZEWGcrVzB6MGlVcmw4Y1ZnYkd6dWFhSnZCaWJ5M09rTWV1ckZ5S2c9</response>

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1YRytUU0hZeDYranVHaVNTWUhmTXVDeHpDKzFKVVlucDVsbFNYRGF1ZnJvPQ==</success>

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost >> <iq xmlns="jabber:client" id="PnsJW5u039s9KvhTOX2hDAw" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost << <iq id="PnsJW5u039s9KvhTOX2hDAw" xmlns="jabber:client" to="http-admin__p7ly3g0191@localhost/993927746-tigase-207" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__p7ly3g0191@localhost/993927746-tigase-207</jid></bind></iq>

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost/993927746-tigase-207 >> <iq xmlns="jabber:client" id="q9KazAbDBeNIDl0mYdsgX7s" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost/993927746-tigase-207 << <iq id="q9KazAbDBeNIDl0mYdsgX7s" xmlns="jabber:client" to="http-admin__p7ly3g0191@localhost/993927746-tigase-207" type="result"/>

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost/993927746-tigase-207 >> <iq to="localhost" id="qaLcDIr9DiVY9n4ueJuk5nY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost/993927746-tigase-207 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost/993927746-tigase-207 << <enabled max="60" location="d4270859fb27" resume="true" id="268b74d1-3832-4069-953c-c917949340d7" xmlns="urn:xmpp:sm:3"/>

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost/993927746-tigase-207 >> <iq id="FpssgX7s6k6lYfY9Cgzbwh0" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost/993927746-tigase-207 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost/993927746-tigase-207 << <iq id="FpssgX7s6k6lYfY9Cgzbwh0" xmlns="jabber:client" to="http-admin__p7ly3g0191@localhost/993927746-tigase-207" type="result"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-24 19:13:01 | http-admin_ :: http-admin__p7ly3g0191@localhost/993927746-tigase-207 << <presence from="http-admin__p7ly3g0191@localhost/993927746-tigase-207" xmlns="jabber:client" to="http-admin__p7ly3g0191@localhost"><c hash="sha-1" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2964] Connector  state changed: disconnecting->disconnected

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

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

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@148179d5

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

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

2019-11-24 19:13:01 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a468535}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@1e7912a5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5b7b8f0e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@442b0a65}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:01 PST 2019}}}}

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

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

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

2019-11-24 19:13:01 | [Mutex] waiting for: [registration]

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6aea50f8

2019-11-24 19:13:01 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a468535}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@1e7912a5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5b7b8f0e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@442b0a65}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:01 PST 2019}}}}

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@3c508b3a

2019-11-24 19:13:01 | 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-24 19:13:01 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b547041}

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2968] Start TLS

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2970] Proceeding TLS

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

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

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2970] Start handshake

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@27b02d6c

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1fe5c4f2

2019-11-24 19:13:01 | 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-24 19:13:01 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2754856f}

2019-11-24 19:13:01 | 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-24 19:13:01 | http-admin_ :: null >> <iq to="localhost" id="Amh9CAq7gSbzmUWkNS3An4a" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 19:13:01 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2922c401}

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

2019-11-24 19:13:01 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3f1a2fbc}

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@19e7ae7e

2019-11-24 19:13:01 | http-admin_ :: null >> <iq to="localhost" id="6uD8wjEEJFyiIST4rmVamLz" type="set"><query xmlns="jabber:iq:register"><username>http-admin__w90220192</username><password>http-admin__w90220192</password><email>17b5f96d-b991-4924-8e85-45a2f8ea83ba@localhost</email></query></iq>

2019-11-24 19:13:01 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3d7fbe33}

2019-11-24 19:13:01 | http-admin_ :: null << <iq from="localhost" id="6uD8wjEEJFyiIST4rmVamLz" xmlns="jabber:client" type="result"/>

2019-11-24 19:13:01 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@28942be4}

2019-11-24 19:13:01 | [Mutex] received everything.

2019-11-24 19:13:01 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2970] Connector  state changed: disconnecting->disconnected

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2970] Stream terminated

2019-11-24 19:13:01 | 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;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b547041, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2754856f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a468535}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@1e7912a5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5b7b8f0e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@442b0a65}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:01 PST 2019}}}}

2019-11-24 19:13:01 | 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;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3b547041, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2754856f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1a468535}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@1e7912a5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5b7b8f0e}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@442b0a65}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:01 PST 2019}}}}

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2b68ac64

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@4561117a

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6151c3f6

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

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2975] Start TLS

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@68130f33

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@6f695d9

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@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-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2977] Proceeding TLS

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2977] Start handshake

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@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-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX193OTAyMjAxOTIscj1Ha2RTM2w3OVlCNXI2enZ6aDQ0Zw==</auth>

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Ha2RTM2w3OVlCNXI2enZ6aDQ0Z1hjaUdsdGdRbGExclFud3Brcjh2LHM9a0hzb0FEck5QR092N3c9PSxpPTQwOTY=</challenge>

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R2tkUzNsNzlZQjVyNnp2emg0NGdYY2lHbHRnUWxhMXJRbndwa3I4dixwPVNGVXQyWlNJcUFkVkpPQ3FaalFLR05neTNmUFd1QXdhMW1VSUg4a1RtSjA9</response>

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj12aHBkV25LZFlHUUQ5ZS9YNmtZeWNDZkF5UkZFR3VjK2xKblVvSDA4VlowPQ==</success>

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost >> <iq xmlns="jabber:client" id="gj46lYfY9Cgzbwh01jXWdyj" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost << <iq id="gj46lYfY9Cgzbwh01jXWdyj" xmlns="jabber:client" to="http-admin__w90220192@localhost/993927746-tigase-208" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__w90220192@localhost/993927746-tigase-208</jid></bind></iq>

2019-11-24 19:13:01 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost/993927746-tigase-208 >> <iq xmlns="jabber:client" id="WfQmXmJJNCzgJxo8wjEEJFy" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost/993927746-tigase-208 << <iq id="WfQmXmJJNCzgJxo8wjEEJFy" xmlns="jabber:client" to="http-admin__w90220192@localhost/993927746-tigase-208" type="result"/>

2019-11-24 19:13:01 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost/993927746-tigase-208 >> <iq to="localhost" id="6xGeIHqcPRW4gY5sdU1mKx7" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost/993927746-tigase-208 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost/993927746-tigase-208 << <enabled max="60" location="d4270859fb27" resume="true" id="70ba57cc-f2df-4006-b8cd-9c537c5150a1" xmlns="urn:xmpp:sm:3"/>

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost/993927746-tigase-208 >> <iq id="stsSLNVS5iNFEEynMUfHCqY" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost/993927746-tigase-208 << <iq id="stsSLNVS5iNFEEynMUfHCqY" xmlns="jabber:client" to="http-admin__w90220192@localhost/993927746-tigase-208" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost/993927746-tigase-208 >> <message to="http-admin__p7ly3g0191@localhost" id="lJc7y8jFudSLNVS5iNFEEyn"><body>Test message 1</body></message>

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

2019-11-24 19:13:01 | http-admin_ :: http-admin__w90220192@localhost/993927746-tigase-208 >> <message to="http-admin__p7ly3g0191@localhost" id="aiRABp2gEKDypiNUQJvazAb"><body>Test message 2</body></message>

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2977] Connector  state changed: connected->disconnected

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2977] Stream terminated

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

2019-11-24 19:13:03 | 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.414s
2019-11-24 19:13:03 |

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

2019-11-24 19:13:03 | ------------------------------------

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

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

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5aaf35cc

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

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

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

2019-11-24 19:13:03 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5468c0e9}, 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@50575ebc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1555cad2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@36778ce1}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:03 PST 2019}}}}

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

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

2019-11-24 19:13:03 | [Mutex] waiting for: [registration]

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

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@248a7d4e

2019-11-24 19:13:03 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5468c0e9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@50575ebc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1555cad2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@36778ce1}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:03 PST 2019}}}}

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@4e4265dd

2019-11-24 19:13:03 | 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-24 19:13:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@757a359d}

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2981] Start TLS

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

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

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2983] Proceeding TLS

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2983] Start handshake

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

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7f60af57

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@877cdf8

2019-11-24 19:13:03 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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-24 19:13:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@55462da6}

2019-11-24 19:13:03 | 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-24 19:13:03 | http-admin_ :: null >> <iq to="localhost" id="CDMq6tYi1fICmateL0dKw5d" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 19:13:03 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4b2ee894}

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

2019-11-24 19:13:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@71342c4e}

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@b543f28

2019-11-24 19:13:03 | http-admin_ :: null >> <iq to="localhost" id="nEN8jFudSLNVS5iNFEEynMU" type="set"><query xmlns="jabber:iq:register"><username>http-admin__oe2q3m0193</username><password>http-admin__oe2q3m0193</password><email>5950aaa0-e43f-4729-9f3b-1e4b5c87c660@localhost</email></query></iq>

2019-11-24 19:13:03 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d3f94b6d}

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

2019-11-24 19:13:03 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3dfa3bb7}

2019-11-24 19:13:03 | [Mutex] received everything.

2019-11-24 19:13:03 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-24 19:13:03 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@757a359d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@55462da6]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5468c0e9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@50575ebc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1555cad2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@36778ce1}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:03 PST 2019}}}}

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2983] Connector  state changed: disconnecting->disconnected

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2983] Stream terminated

2019-11-24 19:13:03 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@757a359d, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@55462da6]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5468c0e9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@50575ebc}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1555cad2}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@36778ce1}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:03 PST 2019}}}}

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@59b50ab3

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@9b30b97

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

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

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

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2334d8f6

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

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

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4fff78a4

2019-11-24 19:13:03 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@3eee137a

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

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

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

2019-11-24 19:13:03 | http-admin_ :: http-admin__oe2q3m0193@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-24 19:13:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=2988] Start TLS

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

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=2990] Proceeding TLS

2019-11-24 19:13:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=473 thread=2990] Start handshake

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

2019-11-24 19:13:03 | http-admin_ :: http-admin__oe2q3m0193@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-24 19:13:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

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

2019-11-24 19:13:03 | http-admin_ :: http-admin__oe2q3m0193@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19vZTJxM20wMTkzLHI9SXNWVUJuNG5yazFialliMk9wRm4=</auth>

2019-11-24 19:13:03 | http-admin_ :: http-admin__oe2q3m0193@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Jc1ZVQm40bnJrMWJqWWIyT3BGbllhSG9GNUVIYXl3azJOdFFtdXc2LHM9eXY3QlBEWGRuVU42eWc9PSxpPTQwOTY=</challenge>

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SXNWVUJuNG5yazFialliMk9wRm5ZYUhvRjVFSGF5d2syTnRRbXV3NixwPUhHMGdONzlPQnorclBCQnNJL3J0dVNWNDdXY085STNFMkxIaGYwallVS1k9</response>

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1pWkZGOGIyMFpVbllBemsrbVVFUDJ3K0ZtZ2JYek53eTZlYWdkazNvOWxJPQ==</success>

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost >> <iq xmlns="jabber:client" id="SytMAdt6rkFBx6xcBhS6sbo" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost << <iq id="SytMAdt6rkFBx6xcBhS6sbo" xmlns="jabber:client" to="http-admin__oe2q3m0193@localhost/993927746-tigase-209" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__oe2q3m0193@localhost/993927746-tigase-209</jid></bind></iq>

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost/993927746-tigase-209 >> <iq xmlns="jabber:client" id="0HSiVY9n4ueJuk5nY8oeBuh" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost/993927746-tigase-209 << <iq id="0HSiVY9n4ueJuk5nY8oeBuh" xmlns="jabber:client" to="http-admin__oe2q3m0193@localhost/993927746-tigase-209" type="result"/>

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost/993927746-tigase-209 >> <iq to="localhost" id="6HQymZ0m9veEqiJKN4l027h" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost/993927746-tigase-209 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost/993927746-tigase-209 << <enabled max="60" location="d4270859fb27" resume="true" id="b974e173-a6c5-4473-add3-365428c4bcc5" xmlns="urn:xmpp:sm:3"/>

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost/993927746-tigase-209 >> <iq id="HKXRV4kM09Atq3qSNDq5CfL" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-24 19:13:04 | http-admin_ :: http-admin__oe2q3m0193@localhost/993927746-tigase-209 << <iq id="HKXRV4kM09Atq3qSNDq5CfL" xmlns="jabber:client" to="http-admin__oe2q3m0193@localhost/993927746-tigase-209" type="result"><query xmlns="jabber:iq:roster"/></iq>

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

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

2019-11-24 19:13:04 | null / [TestClass name=class tigase.tests.http.TestAdminUI]

2019-11-24 19:13:04 | ------------------------------------

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

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4a3e01e

2019-11-24 19:13:04 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@a641efa}, 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@e5b8b6e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4b5914c1}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@50e1bea4}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:04 PST 2019}}}}

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

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

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

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

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

2019-11-24 19:13:04 | [Mutex] waiting for: [registration]

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7ad8f98c

2019-11-24 19:13:04 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@a641efa}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@e5b8b6e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4b5914c1}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@50e1bea4}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:04 PST 2019}}}}

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@288a0d42

2019-11-24 19:13:04 | 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-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=2993] Start TLS

2019-11-24 19:13:04 | 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-24 19:13:04 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2b76eb8e}

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

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

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=2995] Proceeding TLS

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=2995] Start handshake

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@76bf64da

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@4b16f718

2019-11-24 19:13:04 | 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-24 19:13:04 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@338e0325}

2019-11-24 19:13:04 | 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-24 19:13:04 | http-admin_ :: null >> <iq to="localhost" id="8FG9k0r5oY4AjU7IDAcrV0f" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-24 19:13:04 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@fe748a64}

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

2019-11-24 19:13:04 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2f38b441}

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@22ac8cc8

2019-11-24 19:13:04 | http-admin_ :: null >> <iq to="localhost" id="gyjAjU7IDAcrV0fWT3rU9q3" type="set"><query xmlns="jabber:iq:register"><username>http-admin__bjxwbp0194</username><password>http-admin__bjxwbp0194</password><email>4bcad61c-2e2d-4e43-8ce6-c47d06ea89b1@localhost</email></query></iq>

2019-11-24 19:13:04 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6f96187}

2019-11-24 19:13:04 | http-admin_ :: null << <iq from="localhost" id="gyjAjU7IDAcrV0fWT3rU9q3" xmlns="jabber:client" type="result"/>

2019-11-24 19:13:04 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5efe01b2}

2019-11-24 19:13:04 | [Mutex] received everything.

2019-11-24 19:13:04 | [Mutex] isItemNotified: registrationSuccess :: true

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

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

2019-11-24 19:13:04 | 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;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2b76eb8e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@338e0325]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@a641efa}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@e5b8b6e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4b5914c1}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@50e1bea4}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:04 PST 2019}}}}

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=2995] Connector  state changed: disconnecting->disconnected

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=474 thread=2995] Stream terminated

2019-11-24 19:13:04 | 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;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2b76eb8e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@338e0325]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@a641efa}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@e5b8b6e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@4b5914c1}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@50e1bea4}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Sun Nov 24 19:13:04 PST 2019}}}}

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1d2ab663

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@77da933b

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@31d69bc4

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@1f8befdd

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@575adbe1

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

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@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-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=3000] Start TLS

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=3002] Proceeding TLS

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=3002] Start handshake

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@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-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19ianh3YnAwMTk0LHI9QTEzcHEwb0RoOGVZZXlneFdpQkY=</auth>

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BMTNwcTBvRGg4ZVlleWd4V2lCRkJRbUh6V09QMm5sQXBITmdSUUlkLHM9RUk0bU1jVEN6WjVrdUE9PSxpPTQwOTY=</challenge>

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QTEzcHEwb0RoOGVZZXlneFdpQkZCUW1IeldPUDJubEFwSE5nUlFJZCxwPXRZMVVkUlpFaFNzaC91eCtjZEdhWWh6T1VwZFBPWVR3S1Y4dXhuSlhINU09</response>

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1MNkoxcHBOSk1iYkVaVlN6Z2dpQkZyRXVCOWh2OE9xSVZsSEJ1NUNUd2NrPQ==</success>

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost >> <iq xmlns="jabber:client" id="sGFiBthAv8t1m4o38CFxiMG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost << <iq id="sGFiBthAv8t1m4o38CFxiMG" xmlns="jabber:client" to="http-admin__bjxwbp0194@localhost/993927746-tigase-210" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__bjxwbp0194@localhost/993927746-tigase-210</jid></bind></iq>

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost/993927746-tigase-210 >> <iq xmlns="jabber:client" id="hUjhQZs7y8jFudSLNVS5iNF" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost/993927746-tigase-210 << <iq id="hUjhQZs7y8jFudSLNVS5iNF" xmlns="jabber:client" to="http-admin__bjxwbp0194@localhost/993927746-tigase-210" type="result"/>

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost/993927746-tigase-210 >> <iq to="localhost" id="vKNrU9q3bGIGDiWjPSW0s3o" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost/993927746-tigase-210 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost/993927746-tigase-210 << <enabled max="60" location="d4270859fb27" resume="true" id="ad309a0b-9f42-451f-9cc5-2b2f28011177" xmlns="urn:xmpp:sm:3"/>

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost/993927746-tigase-210 >> <iq id="IVijQSScxm1wfOElJCtoNR3" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-24 19:13:04 | http-admin_ :: http-admin__bjxwbp0194@localhost/993927746-tigase-210 << <iq id="IVijQSScxm1wfOElJCtoNR3" xmlns="jabber:client" to="http-admin__bjxwbp0194@localhost/993927746-tigase-210" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=1] Connector  state changed: connected->disconnecting

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

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

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2019-11-24 19:13:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=475 thread=3002] Connector  state changed: disconnecting->disconnected

2019-11-24 19:13:04 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

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