Test duration: 51.977s
| Failed Tests | ||
|---|---|---|
| tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
| testMessageExpiration | 50.348s |
2019-11-21 04:05:57 |
java.lang.AssertionError: User: user_regularprbi4t0183@localhost should have received message: sqbl5o0187 expected [true] but found [false]2019-11-21 04:05:57 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2019-11-21 04:05:57 | ------------------------------------ 2019-11-21 04:05:57 | [Mutex] isItemNotified: node_qfo3qj0184:exists :: false 2019-11-21 04:05:57 | [Mutex] waiting for: [node_qfo3qj0184:create_node] 2019-11-21 04:05:57 | [Mutex] received everything. 2019-11-21 04:05:57 | [Mutex] isItemNotified: node_qfo3qj0184:create_node:success :: true 2019-11-21 04:05:57 | [Mutex] waiting for: [node_qfo3qj0184:subscribe_node] 2019-11-21 04:05:57 | [Mutex] received everything. 2019-11-21 04:05:57 | [Mutex] isItemNotified: node_qfo3qj0184:subscribe_node:success :: true 2019-11-21 04:05:57 | ===== publishing normal message (to online) 2019-11-21 04:05:57 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-21 04:05:57 | command: <data><node>node_qfo3qj0184</node><entry><content>content_7txaqd0185</content></entry></data> 2019-11-21 04:05:57 | target: http://localhost:8088 2019-11-21 04:05:57 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2019-11-21 04:05:57 | entity: <data><node>node_qfo3qj0184</node><entry><content>content_7txaqd0185</content></entry></data> 2019-11-21 04:05:58 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 21 Nov 2019 12:05:58 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-21 04:05:58 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>fa242835-92fd-45c3-9203-4fed86bab8c3</value></item-id></result> 2019-11-21 04:05:58 | contains: true 2019-11-21 04:05:58 | [Mutex] received everything. 2019-11-21 04:05:58 | [Mutex] isItemNotified: user_regularprbi4t0183@localhost:message:received:content_7txaqd0185 :: true 2019-11-21 04:05:58 | ===== publishing already old message - expecting message being filtered out (to online) 2019-11-21 04:05:58 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-21 04:05:58 | command: <data><node>node_qfo3qj0184</node><expire-at>2019-11-21T12:05:53Z</expire-at><entry><content>content_5x2ymc0186</content></entry></data> 2019-11-21 04:05:58 | target: http://localhost:8088 2019-11-21 04:05:58 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2019-11-21 04:05:58 | entity: <data><node>node_qfo3qj0184</node><expire-at>2019-11-21T12:05:53Z</expire-at><entry><content>content_5x2ymc0186</content></entry></data> 2019-11-21 04:05:58 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 21 Nov 2019 12:05:58 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-21 04:05:58 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>0e31d97c-e821-4222-93f9-de1a8d105548</value></item-id></result> 2019-11-21 04:05:58 | contains: true 2019-11-21 04:05:58 | [Mutex] waiting for: [user_regularprbi4t0183@localhost:message:received:content_5x2ymc0186] 2019-11-21 04:06:13 | [Mutex] timeout. Not received [user_regularprbi4t0183@localhost:message:received:content_5x2ymc0186] 2019-11-21 04:06:13 | [Mutex] isItemNotified: user_regularprbi4t0183@localhost:message:received:content_5x2ymc0186 :: false 2019-11-21 04:06:13 | ===== publishing normal message (to offline) 2019-11-21 04:06:13 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-21 04:06:13 | command: <data><node>node_qfo3qj0184</node><entry><content>content_sqbl5o0187</content></entry></data> 2019-11-21 04:06:13 | target: http://localhost:8088 2019-11-21 04:06:13 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2019-11-21 04:06:13 | entity: <data><node>node_qfo3qj0184</node><entry><content>content_sqbl5o0187</content></entry></data> 2019-11-21 04:06:13 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 21 Nov 2019 12:06:13 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-21 04:06:13 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>5bf671bf-bd6d-4569-9cdb-93c66defcb99</value></item-id></result> 2019-11-21 04:06:13 | contains: true 2019-11-21 04:06:18 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-21 04:06:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=457 thread=1] DNS entry stored in session object: localhost:5222 2019-11-21 04:06:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=457 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-21 04:06:18 | [Mutex] waiting for: [user_regularprbi4t0183@localhost:message:received:content_sqbl5o0187] 2019-11-21 04:06:48 | [Mutex] timeout. Not received [user_regularprbi4t0183@localhost:message:received:content_sqbl5o0187] 2019-11-21 04:06:48 | [Mutex] isItemNotified: user_regularprbi4t0183@localhost:message:received:content_sqbl5o0187 :: false
org.testng.Assert.fail(Assert.java:96)
org.testng.Assert.failNotEquals(Assert.java:776) org.testng.Assert.assertTrue(Assert.java:44) tigase.tests.pubsub.TestRestApiWithMessageExpiration.testMessageExpiration(TestRestApiWithMessageExpiration.java:151) 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) |