Test duration: 4.977s
Failed Tests | ||
---|---|---|
tigase.tests.http.TestAdminUI | ||
testAddUser | 0.011s |
2019-11-22 19:15:08 |
java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext2019-11-22 19:15:08 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2019-11-22 19:15:08 | ------------------------------------
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471) com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890) com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166) com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316) com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395) tigase.tests.http.TestAdminUI.testAddUser(TestAdminUI.java:102) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) java.base/java.lang.reflect.Method.invoke(Method.java:566) org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124) org.testng.internal.Invoker.invokeMethod(Invoker.java:583) org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719) org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989) org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125) org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109) org.testng.TestRunner.privateRun(TestRunner.java:648) org.testng.TestRunner.run(TestRunner.java:505) org.testng.SuiteRunner.runTest(SuiteRunner.java:455) org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450) org.testng.SuiteRunner.privateRun(SuiteRunner.java:415) org.testng.SuiteRunner.run(SuiteRunner.java:364) org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52) org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84) org.testng.TestNG.runSuitesSequentially(TestNG.java:1208) org.testng.TestNG.runSuitesLocally(TestNG.java:1137) org.testng.TestNG.runSuites(TestNG.java:1049) org.testng.TestNG.run(TestNG.java:1017) org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283) org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75) org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120) org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) |
testAuthorization | 0.003s |
2019-11-22 19:15:08 |
java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext2019-11-22 19:15:08 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2019-11-22 19:15:08 | ------------------------------------
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471) com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890) com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166) com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316) com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395) tigase.tests.http.TestAdminUI.testAuthorization(TestAdminUI.java:76) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) java.base/java.lang.reflect.Method.invoke(Method.java:566) org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124) org.testng.internal.Invoker.invokeMethod(Invoker.java:583) org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719) org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989) org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125) org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109) org.testng.TestRunner.privateRun(TestRunner.java:648) org.testng.TestRunner.run(TestRunner.java:505) org.testng.SuiteRunner.runTest(SuiteRunner.java:455) org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450) org.testng.SuiteRunner.privateRun(SuiteRunner.java:415) org.testng.SuiteRunner.run(SuiteRunner.java:364) org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52) org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84) org.testng.TestNG.runSuitesSequentially(TestNG.java:1208) org.testng.TestNG.runSuitesLocally(TestNG.java:1137) org.testng.TestNG.runSuites(TestNG.java:1049) org.testng.TestNG.run(TestNG.java:1017) org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283) org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75) org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120) org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) |
testCommandsAvailability | 0.001s |
2019-11-22 19:15:08 |
java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext2019-11-22 19:15:08 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2019-11-22 19:15:08 | ------------------------------------
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471) com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890) com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166) com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316) com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395) tigase.tests.http.TestAdminUI.testCommandsAvailability(TestAdminUI.java:89) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) java.base/java.lang.reflect.Method.invoke(Method.java:566) org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124) org.testng.internal.Invoker.invokeMethod(Invoker.java:583) org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719) org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989) org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125) org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109) org.testng.TestRunner.privateRun(TestRunner.java:648) org.testng.TestRunner.run(TestRunner.java:505) org.testng.SuiteRunner.runTest(SuiteRunner.java:455) org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450) org.testng.SuiteRunner.privateRun(SuiteRunner.java:415) org.testng.SuiteRunner.run(SuiteRunner.java:364) org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52) org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84) org.testng.TestNG.runSuitesSequentially(TestNG.java:1208) org.testng.TestNG.runSuitesLocally(TestNG.java:1137) org.testng.TestNG.runSuites(TestNG.java:1049) org.testng.TestNG.run(TestNG.java:1017) org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283) org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75) org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120) org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) |
testDeleteUser | 0.207s |
2019-11-22 19:15:08 |
java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext2019-11-22 19:15:08 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2019-11-22 19:15:08 | ------------------------------------ 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Using XEP-0077 mode!!!! 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Connector state changed: null->connecting 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@c86a970 2019-11-22 19:15:08 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2415690}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@67ec200}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@437c5cab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a88a09d}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:08 PST 2019}}}} 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Connector state changed: connecting->connected 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:15:08 | [Mutex] waiting for: [registration] 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@72f59c8a 2019-11-22 19:15:08 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2415690}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@67ec200}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@437c5cab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a88a09d}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:08 PST 2019}}}} 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2eb3e16 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2939] Start TLS 2019-11-22 19:15:08 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2019-11-22 19:15:08 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2353a3e4} 2019-11-22 19:15:08 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2941] Proceeding TLS 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2941] Start handshake 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@1c60635b 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@42afad91 2019-11-22 19:15:08 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19ef305c} 2019-11-22 19:15:08 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2019-11-22 19:15:08 | http-admin_ :: null >> <iq to="localhost" id="Qec8yt5dLJAfveVTXj1wdVh" type="get"><query xmlns="jabber:iq:register"/></iq> 2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@46de33cd} 2019-11-22 19:15:08 | http-admin_ :: null << <iq id="Qec8yt5dLJAfveVTXj1wdVh" type="result" from="localhost" xmlns="jabber:client"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.Please also provide your e-mail address to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq> 2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@271dfc06} 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@38f82905 2019-11-22 19:15:08 | http-admin_ :: null >> <iq to="localhost" id="WlvKCjDurV1rh2fZpWhGnLR" type="set"><query xmlns="jabber:iq:register"><username>http-admin__u86ty70187</username><password>http-admin__u86ty70187</password><email>f15c04ef-2abc-4dc9-9070-f38f19c25558@localhost</email></query></iq> 2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@32494350} 2019-11-22 19:15:08 | http-admin_ :: null << <iq id="WlvKCjDurV1rh2fZpWhGnLR" type="result" from="localhost" xmlns="jabber:client"/> 2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@704c8ae} 2019-11-22 19:15:08 | [Mutex] received everything. 2019-11-22 19:15:08 | [Mutex] isItemNotified: registrationSuccess :: true 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Connector state changed: connected->disconnecting 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=1] Terminating XMPP Stream 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2941] Connector state changed: disconnecting->disconnected 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=464 thread=2941] Stream terminated 2019-11-22 19:15:08 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2353a3e4, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19ef305c]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2415690}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@67ec200}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@437c5cab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a88a09d}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:08 PST 2019}}}} 2019-11-22 19:15:08 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2353a3e4, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@19ef305c]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2415690}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@67ec200}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@437c5cab}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7a88a09d}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:08 PST 2019}}}} 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@670975c2 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@2fbc48e9 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@56f5fc1a 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@77951fd2 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5b1ec387
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471) com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890) com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166) com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316) com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395) tigase.tests.http.TestAdminUI.testDeleteUser(TestAdminUI.java:136) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) java.base/java.lang.reflect.Method.invoke(Method.java:566) org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124) org.testng.internal.Invoker.invokeMethod(Invoker.java:583) org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719) org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989) org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125) org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109) org.testng.TestRunner.privateRun(TestRunner.java:648) org.testng.TestRunner.run(TestRunner.java:505) org.testng.SuiteRunner.runTest(SuiteRunner.java:455) org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450) org.testng.SuiteRunner.privateRun(SuiteRunner.java:415) org.testng.SuiteRunner.run(SuiteRunner.java:364) org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52) org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84) org.testng.TestNG.runSuitesSequentially(TestNG.java:1208) org.testng.TestNG.runSuitesLocally(TestNG.java:1137) org.testng.TestNG.runSuites(TestNG.java:1049) org.testng.TestNG.run(TestNG.java:1017) org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283) org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75) org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120) org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) |
testGetUserInfoUserOffline | 2.867s |
2019-11-22 19:15:08 |
java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext2019-11-22 19:15:08 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2019-11-22 19:15:08 | ------------------------------------ 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6374d705 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Using XEP-0077 mode!!!! 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Connector state changed: null->connecting 2019-11-22 19:15:08 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6db3251b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@698cbc75}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2c8e2f20}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6987094b}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:08 PST 2019}}}} 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Connector state changed: connecting->connected 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:15:08 | [Mutex] waiting for: [registration] 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1d68629d 2019-11-22 19:15:08 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6db3251b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@698cbc75}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2c8e2f20}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6987094b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:08 PST 2019}}}} 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@118b1a51 2019-11-22 19:15:08 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ca1d06f} 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2946] Start TLS 2019-11-22 19:15:08 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2019-11-22 19:15:08 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2948] Proceeding TLS 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2948] Start handshake 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1d3d45e1 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@431fb051 2019-11-22 19:15:08 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@a8f73f1} 2019-11-22 19:15:08 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2019-11-22 19:15:08 | http-admin_ :: null >> <iq to="localhost" id="baVnLR3uqbMNNS7nNV3ex5o" type="get"><query xmlns="jabber:iq:register"/></iq> 2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6bda709d} 2019-11-22 19:15:08 | http-admin_ :: null << <iq id="baVnLR3uqbMNNS7nNV3ex5o" type="result" from="localhost" xmlns="jabber:client"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.Please also provide your e-mail address to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq> 2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@48efe867} 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3f0aaed6 2019-11-22 19:15:08 | http-admin_ :: null >> <iq to="localhost" id="hvUFKJFCBlJNNIv1gZ1dP3A" type="set"><query xmlns="jabber:iq:register"><username>http-admin__mkg87n0188</username><password>http-admin__mkg87n0188</password><email>217ba8a4-2a8e-49ff-8ea4-7dbb95d16bca@localhost</email></query></iq> 2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@dd2e161c} 2019-11-22 19:15:08 | http-admin_ :: null << <iq id="hvUFKJFCBlJNNIv1gZ1dP3A" type="result" from="localhost" xmlns="jabber:client"/> 2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1290c5e} 2019-11-22 19:15:08 | [Mutex] received everything. 2019-11-22 19:15:08 | [Mutex] isItemNotified: registrationSuccess :: true 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Connector state changed: connected->disconnecting 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=1] Terminating XMPP Stream 2019-11-22 19:15:08 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ca1d06f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@a8f73f1]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6db3251b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@698cbc75}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2c8e2f20}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6987094b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:08 PST 2019}}}} 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2948] Connector state changed: disconnecting->disconnected 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=465 thread=2948] Stream terminated 2019-11-22 19:15:08 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ca1d06f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@a8f73f1]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6db3251b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@698cbc75}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2c8e2f20}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6987094b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:08 PST 2019}}}} 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@70c8f771 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@47d385df 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2dc5ffed 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Connector state changed: null->connecting 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@64475df7 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@53035d71 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Connector state changed: connecting->connected 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2953] Start TLS 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2955] Proceeding TLS 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2955] Start handshake 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19ta2c4N24wMTg4LHI9UzRXN3g2Q2hycTJ4NjZCdDlwWkk=</auth> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TNFc3eDZDaHJxMng2NkJ0OXBaSUNGSkJhWUpoQWZNT1MxY2g1a295LHM9WGFVcy9tdURkYnlnUVE9PSxpPTQwOTY=</challenge> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UzRXN3g2Q2hycTJ4NjZCdDlwWklDRkpCYVlKaEFmTU9TMWNoNWtveSxwPWtKaUpqcktUL09kcWZDVkRzN1JPZ1F2WlhURHRkU1owVzdRZlpQbzlLQkk9</response> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1mZDVBWWRIUUdqaC85VC9BQkNaU3YwaXBxSFVLUHlzMERQVEtCWGVOQzM0PQ==</success> 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost >> <iq xmlns="jabber:client" id="nrG15vdybnYpRTbL0bR9qfC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost << <iq id="nrG15vdybnYpRTbL0bR9qfC" type="result" to="http-admin__mkg87n0188@localhost/993927746-tigase-209" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__mkg87n0188@localhost/993927746-tigase-209</jid></bind></iq> 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 >> <iq xmlns="jabber:client" id="jvQr5shHrdDoRJGPHzxtq1x" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 << <iq id="jvQr5shHrdDoRJGPHzxtq1x" type="result" to="http-admin__mkg87n0188@localhost/993927746-tigase-209" xmlns="jabber:client"/> 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 >> <iq to="localhost" id="BA3N5Bk3etXfP2wnazlYjLz" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 << <enabled id="d2ecea1e-6da9-4d42-abf1-60d061b85710" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 >> <iq id="Ug3FFxctX8JvbLVkP9JAzgx" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 << <iq id="BA3N5Bk3etXfP2wnazlYjLz" type="result" from="localhost" to="http-admin__mkg87n0188@localhost/993927746-tigase-209" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 << <iq id="Ug3FFxctX8JvbLVkP9JAzgx" type="result" to="http-admin__mkg87n0188@localhost/993927746-tigase-209" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Connector state changed: connected->disconnecting 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=1] Terminating XMPP Stream 2019-11-22 19:15:08 | http-admin_ :: http-admin__mkg87n0188@localhost/993927746-tigase-209 << <presence from="http-admin__mkg87n0188@localhost/993927746-tigase-209" to="http-admin__mkg87n0188@localhost" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps"/></presence> 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=466 thread=2955] Connector state changed: disconnecting->disconnected 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Using XEP-0077 mode!!!! 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Connector state changed: null->connecting 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@549304d2 2019-11-22 19:15:08 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5a54f030}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@5e6b6fa2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1b69fa0b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5710c820}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:08 PST 2019}}}} 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Connector state changed: connecting->connected 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2ab86782 2019-11-22 19:15:08 | [Mutex] waiting for: [registration] 2019-11-22 19:15:08 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5a54f030}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@5e6b6fa2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1b69fa0b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5710c820}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:08 PST 2019}}}} 2019-11-22 19:15:08 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2f2b0b08 2019-11-22 19:15:08 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:08 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7b460544} 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2959] Start TLS 2019-11-22 19:15:08 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2019-11-22 19:15:08 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:15:08 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2961] Proceeding TLS 2019-11-22 19:15:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2961] Start handshake 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2ac693c4 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@43ab7569 2019-11-22 19:15:09 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:09 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@342f455f} 2019-11-22 19:15:09 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2019-11-22 19:15:09 | http-admin_ :: null >> <iq to="localhost" id="SqvTVT7r05bADjNZneDLX2t" type="get"><query xmlns="jabber:iq:register"/></iq> 2019-11-22 19:15:09 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@330a1378} 2019-11-22 19:15:09 | http-admin_ :: null << <iq id="SqvTVT7r05bADjNZneDLX2t" type="result" from="localhost" xmlns="jabber:client"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.Please also provide your e-mail address to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq> 2019-11-22 19:15:09 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7f081abb} 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@61ceee2d 2019-11-22 19:15:09 | http-admin_ :: null >> <iq to="localhost" id="gxOAvq5n2r15vdybnYpRTbL" type="set"><query xmlns="jabber:iq:register"><username>http-admin__53ewir0189</username><password>http-admin__53ewir0189</password><email>60b6cd12-8b04-4f31-9734-b861da2b39db@localhost</email></query></iq> 2019-11-22 19:15:09 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@661889de} 2019-11-22 19:15:09 | http-admin_ :: null << <iq id="gxOAvq5n2r15vdybnYpRTbL" type="result" from="localhost" xmlns="jabber:client"/> 2019-11-22 19:15:09 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@79d6df40} 2019-11-22 19:15:09 | [Mutex] received everything. 2019-11-22 19:15:09 | [Mutex] isItemNotified: registrationSuccess :: true 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Connector state changed: connected->disconnecting 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=1] Terminating XMPP Stream 2019-11-22 19:15:09 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7b460544, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@342f455f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5a54f030}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@5e6b6fa2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1b69fa0b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5710c820}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:09 PST 2019}}}} 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2961] Connector state changed: disconnecting->disconnected 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=467 thread=2961] Stream terminated 2019-11-22 19:15:09 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7b460544, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@342f455f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5a54f030}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@5e6b6fa2}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1b69fa0b}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5710c820}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:09 PST 2019}}}} 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@371d6898 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@87f6102 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1ed659a6 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@5135a9e3 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@d3042f5 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Connector state changed: null->connecting 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Connector state changed: connecting->connected 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2966] Start TLS 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2968] Proceeding TLS 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2968] Start handshake 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX181M2V3aXIwMTg5LHI9dFRtcnBMeHFUN2tlUndQRDE1elc=</auth> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10VG1ycEx4cVQ3a2VSd1BEMTV6V0J5TndsNTZQOEMxVEFaa21jQWFQLHM9RUZZa0ZnQ0pnTmdlMVE9PSxpPTQwOTY=</challenge> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dFRtcnBMeHFUN2tlUndQRDE1eldCeU53bDU2UDhDMVRBWmttY0FhUCxwPTZjbkVxY1dGejRxeUlGM1RLOWF0aFMxenJDUU9kM3FCaGE5ZlhXc25pWGc9</response> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1XTXYxTjlFSUt3dklCbkFrUm1BS2xhUmdGVU9CdmsyVUFXTDZtb0hXSmlNPQ==</success> 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost >> <iq xmlns="jabber:client" id="4zSKFP5iZ6drdLUgR8vdINJ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost << <iq id="4zSKFP5iZ6drdLUgR8vdINJ" type="result" to="http-admin__53ewir0189@localhost/993927746-tigase-210" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__53ewir0189@localhost/993927746-tigase-210</jid></bind></iq> 2019-11-22 19:15:09 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <iq xmlns="jabber:client" id="StyZ7hTZ6hzmbpZn9MJXlO1" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 << <iq id="StyZ7hTZ6hzmbpZn9MJXlO1" type="result" to="http-admin__53ewir0189@localhost/993927746-tigase-210" xmlns="jabber:client"/> 2019-11-22 19:15:09 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <iq to="localhost" id="krqzqdzbHBkJtaNDrhXoXpf" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 << <enabled id="b031e3df-1280-4d28-a707-9805a41ce390" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <iq id="NF4Zo1fMVZ1nX29jQ9lR7DK" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 << <iq id="krqzqdzbHBkJtaNDrhXoXpf" type="result" from="localhost" to="http-admin__53ewir0189@localhost/993927746-tigase-210" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 << <iq id="NF4Zo1fMVZ1nX29jQ9lR7DK" type="result" to="http-admin__53ewir0189@localhost/993927746-tigase-210" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <message to="http-admin__mkg87n0188@localhost" id="EF2IPMz9DBACzylT4v9l1fC"><body>Test message 1</body></message> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 << <presence from="http-admin__53ewir0189@localhost/993927746-tigase-210" to="http-admin__53ewir0189@localhost" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps"/></presence> 2019-11-22 19:15:09 | http-admin_ :: http-admin__53ewir0189@localhost/993927746-tigase-210 >> <message to="http-admin__mkg87n0188@localhost" id="zEXP8rnbunSLxp9GOXkTZgT"><body>Test message 2</body></message> 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2968] Connector state changed: connected->disconnected 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=468 thread=2968] Stream terminated 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471) com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890) com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166) com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316) com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395) tigase.tests.http.TestAdminUI.testGetUserInfoUserOffline(TestAdminUI.java:287) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) java.base/java.lang.reflect.Method.invoke(Method.java:566) org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124) org.testng.internal.Invoker.invokeMethod(Invoker.java:583) org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719) org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989) org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125) org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109) org.testng.TestRunner.privateRun(TestRunner.java:648) org.testng.TestRunner.run(TestRunner.java:505) org.testng.SuiteRunner.runTest(SuiteRunner.java:455) org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450) org.testng.SuiteRunner.privateRun(SuiteRunner.java:415) org.testng.SuiteRunner.run(SuiteRunner.java:364) org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52) org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84) org.testng.TestNG.runSuitesSequentially(TestNG.java:1208) org.testng.TestNG.runSuitesLocally(TestNG.java:1137) org.testng.TestNG.runSuites(TestNG.java:1049) org.testng.TestNG.run(TestNG.java:1017) org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283) org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75) org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120) org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) |
testGetUserInfoUserOnline | 0.475s |
2019-11-22 19:15:11 |
java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext2019-11-22 19:15:11 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2019-11-22 19:15:11 | ------------------------------------ 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Using XEP-0077 mode!!!! 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Connector state changed: null->connecting 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@167be285 2019-11-22 19:15:11 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18bc1e3a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1c8389f5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59811401}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1027aa7e}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:11 PST 2019}}}} 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Connector state changed: connecting->connected 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:15:11 | [Mutex] waiting for: [registration] 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@68122b8e 2019-11-22 19:15:11 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18bc1e3a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1c8389f5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59811401}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1027aa7e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:11 PST 2019}}}} 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@685ecb58 2019-11-22 19:15:11 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39aeeb4e} 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2972] Start TLS 2019-11-22 19:15:11 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2019-11-22 19:15:11 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:15:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2974] Proceeding TLS 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2974] Start handshake 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@14f7c25f 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@6d40d514 2019-11-22 19:15:11 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@735ac7ef} 2019-11-22 19:15:11 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2019-11-22 19:15:11 | http-admin_ :: null >> <iq to="localhost" id="wLcX5zxyh3xcNIrT7zwuj2j" type="get"><query xmlns="jabber:iq:register"/></iq> 2019-11-22 19:15:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5825176a} 2019-11-22 19:15:11 | http-admin_ :: null << <iq id="wLcX5zxyh3xcNIrT7zwuj2j" type="result" from="localhost" xmlns="jabber:client"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.Please also provide your e-mail address to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq> 2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3de0b651} 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@17af7e88 2019-11-22 19:15:11 | http-admin_ :: null >> <iq to="localhost" id="xmXBBBGxzzgVYXVbHM0l6r5" type="set"><query xmlns="jabber:iq:register"><username>http-admin__f9ggsu0190</username><password>http-admin__f9ggsu0190</password><email>0d7b6582-9b0f-49a0-a917-c01951cdb522@localhost</email></query></iq> 2019-11-22 19:15:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4d650ab0} 2019-11-22 19:15:11 | http-admin_ :: null << <iq id="xmXBBBGxzzgVYXVbHM0l6r5" type="result" from="localhost" xmlns="jabber:client"/> 2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7cace11c} 2019-11-22 19:15:11 | [Mutex] received everything. 2019-11-22 19:15:11 | [Mutex] isItemNotified: registrationSuccess :: true 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Connector state changed: connected->disconnecting 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=1] Terminating XMPP Stream 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2974] Connector state changed: disconnecting->disconnected 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=469 thread=2974] Stream terminated 2019-11-22 19:15:11 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39aeeb4e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@735ac7ef]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18bc1e3a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1c8389f5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59811401}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1027aa7e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:11 PST 2019}}}} 2019-11-22 19:15:11 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@39aeeb4e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@735ac7ef]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@18bc1e3a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1c8389f5}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@59811401}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1027aa7e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:11 PST 2019}}}} 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@59ec24d9 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@6106538b 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@d313a1d 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@160e9ea6 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2e7caa52 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Connector state changed: null->connecting 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Connector state changed: connecting->connected 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2979] Start TLS 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2981] Proceeding TLS 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=470 thread=2981] Start handshake 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX19mOWdnc3UwMTkwLHI9c0twemJyWUVweGJxODUwejdsaEU=</auth> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zS3B6YnJZRXB4YnE4NTB6N2xoRXNrVzBTVzhDR2VOVlVmaXVwVGU3LHM9cng5NUpzQ1NSSC8xVlE9PSxpPTQwOTY=</challenge> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c0twemJyWUVweGJxODUwejdsaEVza1cwU1c4Q0dlTlZVZml1cFRlNyxwPVI1TG1aQVludTBqWThtLzJLZ3AxMVZkMFduMzJSd21CTzNVak10VU0vOEk9</response> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1IS3hyWXd4Ulc5K2VZakVqOElQSjdsUll4S1RQYXVMU1QvSUt0NDBldXpFPQ==</success> 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost >> <iq xmlns="jabber:client" id="ssd13k7hJR7IBHPMX25bHJQ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost << <iq id="ssd13k7hJR7IBHPMX25bHJQ" type="result" to="http-admin__f9ggsu0190@localhost/993927746-tigase-211" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__f9ggsu0190@localhost/993927746-tigase-211</jid></bind></iq> 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 >> <iq xmlns="jabber:client" id="FtenSLxp9GOXkTZgTVT7r05" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 << <iq id="FtenSLxp9GOXkTZgTVT7r05" type="result" to="http-admin__f9ggsu0190@localhost/993927746-tigase-211" xmlns="jabber:client"/> 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 >> <iq to="localhost" id="cnUl1n8ILW7raHx7zlOHp2x" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 >> <iq id="jN81fMVZ1nX29jQ9lR7DKFP" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 << <enabled id="b9a9d42c-bb05-4cd1-9cad-a6f1fba10579" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 << <iq id="cnUl1n8ILW7raHx7zlOHp2x" type="result" from="localhost" to="http-admin__f9ggsu0190@localhost/993927746-tigase-211" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 << <iq id="jN81fMVZ1nX29jQ9lR7DKFP" type="result" to="http-admin__f9ggsu0190@localhost/993927746-tigase-211" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:15:11 | http-admin_ :: http-admin__f9ggsu0190@localhost/993927746-tigase-211 << <presence from="http-admin__f9ggsu0190@localhost/993927746-tigase-211" to="http-admin__f9ggsu0190@localhost" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps"/></presence>
org.apache.commons.lang3.Validate.isTrue(Validate.java:155)
org.apache.commons.lang3.reflect.FieldUtils.readDeclaredField(FieldUtils.java:471) com.gargoylesoftware.htmlunit.HttpWebConnection.createConnectionManager(HttpWebConnection.java:890) com.gargoylesoftware.htmlunit.HttpWebConnection.getResponse(HttpWebConnection.java:166) com.gargoylesoftware.htmlunit.WebClient.loadWebResponseFromWebConnection(WebClient.java:1316) com.gargoylesoftware.htmlunit.WebClient.loadWebResponse(WebClient.java:1233) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:341) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:410) com.gargoylesoftware.htmlunit.WebClient.getPage(WebClient.java:395) tigase.tests.http.TestAdminUI.testGetUserInfoUserOnline(TestAdminUI.java:239) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) java.base/java.lang.reflect.Method.invoke(Method.java:566) org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:124) org.testng.internal.Invoker.invokeMethod(Invoker.java:583) org.testng.internal.Invoker.invokeTestMethod(Invoker.java:719) org.testng.internal.Invoker.invokeTestMethods(Invoker.java:989) org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125) org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109) org.testng.TestRunner.privateRun(TestRunner.java:648) org.testng.TestRunner.run(TestRunner.java:505) org.testng.SuiteRunner.runTest(SuiteRunner.java:455) org.testng.SuiteRunner.runSequentially(SuiteRunner.java:450) org.testng.SuiteRunner.privateRun(SuiteRunner.java:415) org.testng.SuiteRunner.run(SuiteRunner.java:364) org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52) org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:84) org.testng.TestNG.runSuitesSequentially(TestNG.java:1208) org.testng.TestNG.runSuitesLocally(TestNG.java:1137) org.testng.TestNG.runSuites(TestNG.java:1049) org.testng.TestNG.run(TestNG.java:1017) org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283) org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75) org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120) org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) |
testModifyUser | 0.392s |
2019-11-22 19:15:11 |
java.lang.IllegalArgumentException: Cannot locate declared field class org.apache.http.impl.client.HttpClientBuilder.sslcontext2019-11-22 19:15:11 | null / [TestClass name=class tigase.tests.http.TestAdminUI] 2019-11-22 19:15:11 | ------------------------------------ 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Using XEP-0077 mode!!!! 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Connector state changed: null->connecting 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@13e017bb 2019-11-22 19:15:11 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1d27ebb7}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@19187ccb}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5c1ae18c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f54687b}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:11 PST 2019}}}} 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Connector state changed: connecting->connected 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:11 | [Mutex] waiting for: [registration] 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6d8c5875 2019-11-22 19:15:11 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1d27ebb7}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@19187ccb}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5c1ae18c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f54687b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:11 PST 2019}}}} 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@37288f2b 2019-11-22 19:15:11 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3c351ec3} 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2984] Start TLS 2019-11-22 19:15:11 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2019-11-22 19:15:11 | http-admin_ :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:15:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3} 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2986] Proceeding TLS 2019-11-22 19:15:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2986] Start handshake 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@504ebe8e 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5f0e0b02 2019-11-22 19:15:11 | http-admin_ :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2c2c861f} 2019-11-22 19:15:11 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>] 2019-11-22 19:15:11 | http-admin_ :: null >> <iq to="localhost" id="2zqLVkP9JAzgx5vl4Avq5n2" type="get"><query xmlns="jabber:iq:register"/></iq> 2019-11-22 19:15:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3af053cf} 2019-11-22 19:15:11 | http-admin_ :: null << <iq id="2zqLVkP9JAzgx5vl4Avq5n2" type="result" from="localhost" xmlns="jabber:client"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.Please also provide your e-mail address to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq> 2019-11-22 19:15:11 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@387b465f} 2019-11-22 19:15:11 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1de42510 2019-11-22 19:15:11 | http-admin_ :: null >> <iq to="localhost" id="ps3X7mNBqjFvpdUZtnS9qRJ" type="set"><query xmlns="jabber:iq:register"><username>http-admin__8rgwty0191</username><password>http-admin__8rgwty0191</password><email>24c0cf95-81ee-4eef-aa16-d2465c086f5e@localhost</email></query></iq> 2019-11-22 19:15:11 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1c25ae35} 2019-11-22 19:15:12 | http-admin_ :: null << <iq id="ps3X7mNBqjFvpdUZtnS9qRJ" type="result" from="localhost" xmlns="jabber:client"/> 2019-11-22 19:15:12 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@329d7bb5} 2019-11-22 19:15:12 | [Mutex] received everything. 2019-11-22 19:15:12 | [Mutex] isItemNotified: registrationSuccess :: true 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Connector state changed: connected->disconnecting 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=1] Terminating XMPP Stream 2019-11-22 19:15:12 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3c351ec3, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2c2c861f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1d27ebb7}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@19187ccb}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5c1ae18c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f54687b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:12 PST 2019}}}} 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2986] Connector state changed: disconnecting->disconnected 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=471 thread=2986] Stream terminated 2019-11-22 19:15:12 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3e351d55}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3c351ec3, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2c2c861f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1d27ebb7}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@62afee85}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@19187ccb}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@5c1ae18c}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4f54687b}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=http-admin_}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Fri Nov 22 19:15:12 PST 2019}}}} 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7ac90f87 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@18e2e73f 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@24929d96 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Connector state changed: null->connecting 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7d8b0a62 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@4f8c8763 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Connector state changed: connecting->connected 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2991] Start TLS 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2993] Proceeding TLS 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2993] Start handshake 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1odHRwLWFkbWluX184cmd3dHkwMTkxLHI9Z2Z4MDVsZjFhdmdIbmRpaVg4RWM=</auth> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nZngwNWxmMWF2Z0huZGlpWDhFY3NYb0dFZ1pER1Fza3RheW9VaGQyLHM9QnVIUTdnOGNBOXUyT2c9PSxpPTQwOTY=</challenge> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z2Z4MDVsZjFhdmdIbmRpaVg4RWNzWG9HRWdaREdRc2t0YXlvVWhkMixwPXU3Z0h4eCtRMFI1NWQ0UFRPZG5GTmNuL1ZNSmlicnc3eDZ6YXdPUHIwRzA9</response> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1qcUNIRVlvbEp6Qm1HdGE1YjFaTmk5bG94YktQSGJjWTQzYjRlUHNmSlJzPQ==</success> 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost >> <iq xmlns="jabber:client" id="UzmhTZ6hzmbpZn9MJXlO1al" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost << <iq id="UzmhTZ6hzmbpZn9MJXlO1al" type="result" to="http-admin__8rgwty0191@localhost/993927746-tigase-212" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>http-admin__8rgwty0191@localhost/993927746-tigase-212</jid></bind></iq> 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 >> <iq xmlns="jabber:client" id="ESf8FsVR3rgYhYbzqdzbHBk" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 << <iq id="ESf8FsVR3rgYhYbzqdzbHBk" type="result" to="http-admin__8rgwty0191@localhost/993927746-tigase-212" xmlns="jabber:client"/> 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 >> <iq to="localhost" id="Jt0R3uqbMNNS7nNV3ex5ofx" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 << <enabled id="b7898bbc-a9fb-4ab6-ae2a-5321de173cdd" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 >> <iq id="nQ5PHJFsZZcRLHNZs5FLEHw" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 << <iq id="Jt0R3uqbMNNS7nNV3ex5ofx" type="result" from="localhost" to="http-admin__8rgwty0191@localhost/993927746-tigase-212" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 << <iq id="nQ5PHJFsZZcRLHNZs5FLEHw" type="result" to="http-admin__8rgwty0191@localhost/993927746-tigase-212" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Connector state changed: connected->disconnecting 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=1] Terminating XMPP Stream 2019-11-22 19:15:12 | http-admin_ :: http-admin__8rgwty0191@localhost/993927746-tigase-212 << <presence from="http-admin__8rgwty0191@localhost/993927746-tigase-212" to="http-admin__8rgwty0191@localhost" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps"/></presence> 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2993] Connector state changed: disconnecting->disconnected 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=472 thread=2993] Stream terminated 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:15:12 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:15:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted
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) |