Test duration: 45.260s
| Passed Tests | ||
|---|---|---|
| tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
| testMessageExpiration | 43.638s |
2019-11-25 19:00:51 |
2019-11-25 19:00:51 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2019-11-25 19:00:51 | ------------------------------------ 2019-11-25 19:00:51 | [Mutex] isItemNotified: node_v1iszb0184:exists :: false 2019-11-25 19:00:51 | [Mutex] waiting for: [node_v1iszb0184:create_node] 2019-11-25 19:00:51 | [Mutex] received everything. 2019-11-25 19:00:51 | [Mutex] isItemNotified: node_v1iszb0184:create_node:success :: true 2019-11-25 19:00:51 | [Mutex] waiting for: [node_v1iszb0184:subscribe_node] 2019-11-25 19:00:51 | [Mutex] received everything. 2019-11-25 19:00:51 | [Mutex] isItemNotified: node_v1iszb0184:subscribe_node:success :: true 2019-11-25 19:00:51 | ===== publishing normal message (to online) 2019-11-25 19:00:51 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-25 19:00:51 | command: <data><node>node_v1iszb0184</node><entry><content>content_g8o7640185</content></entry></data> 2019-11-25 19:00:51 | target: http://localhost:8088 2019-11-25 19:00:51 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2019-11-25 19:00:51 | entity: <data><node>node_v1iszb0184</node><entry><content>content_g8o7640185</content></entry></data> 2019-11-25 19:00:51 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 26 Nov 2019 03:00:51 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-25 19:00:51 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>4d04db5d-a1de-4934-8442-3a372339701b</value></item-id></result> 2019-11-25 19:00:51 | contains: true 2019-11-25 19:00:51 | [Mutex] received everything. 2019-11-25 19:00:51 | [Mutex] isItemNotified: user_regularrln0sr0183@localhost:message:received:content_g8o7640185 :: true 2019-11-25 19:00:51 | ===== publishing already old message - expecting message being filtered out (to online) 2019-11-25 19:00:51 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-25 19:00:51 | command: <data><node>node_v1iszb0184</node><expire-at>2019-11-26T03:00:46Z</expire-at><entry><content>content_gp1gri0186</content></entry></data> 2019-11-25 19:00:51 | target: http://localhost:8088 2019-11-25 19:00:51 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2019-11-25 19:00:51 | entity: <data><node>node_v1iszb0184</node><expire-at>2019-11-26T03:00:46Z</expire-at><entry><content>content_gp1gri0186</content></entry></data> 2019-11-25 19:00:51 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 26 Nov 2019 03:00:51 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-25 19:00:51 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>a1a949bd-cba3-4e93-8dc8-482a664baba5</value></item-id></result> 2019-11-25 19:00:51 | contains: true 2019-11-25 19:00:51 | [Mutex] waiting for: [user_regularrln0sr0183@localhost:message:received:content_gp1gri0186] 2019-11-25 19:01:06 | [Mutex] timeout. Not received [user_regularrln0sr0183@localhost:message:received:content_gp1gri0186] 2019-11-25 19:01:06 | [Mutex] isItemNotified: user_regularrln0sr0183@localhost:message:received:content_gp1gri0186 :: false 2019-11-25 19:01:06 | ===== publishing normal message (to offline) 2019-11-25 19:01:06 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-25 19:01:06 | command: <data><node>node_v1iszb0184</node><entry><content>content_b6luz80187</content></entry></data> 2019-11-25 19:01:06 | target: http://localhost:8088 2019-11-25 19:01:06 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2019-11-25 19:01:06 | entity: <data><node>node_v1iszb0184</node><entry><content>content_b6luz80187</content></entry></data> 2019-11-25 19:01:06 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 26 Nov 2019 03:01:06 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-25 19:01:06 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>1fba6102-ae1d-469a-9ed2-fe6608c4f504</value></item-id></result> 2019-11-25 19:01:06 | contains: true 2019-11-25 19:01:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-25 19:01:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=457 thread=1] DNS entry stored in session object: localhost:5222 2019-11-25 19:01:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=457 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-25 19:01:11 | [Mutex] waiting for: [user_regularrln0sr0183@localhost:message:received:content_b6luz80187] 2019-11-25 19:01:11 | [Mutex] received everything. 2019-11-25 19:01:11 | [Mutex] isItemNotified: user_regularrln0sr0183@localhost:message:received:content_b6luz80187 :: true 2019-11-25 19:01:11 | ===== publishing already old message - expecting message being filtered out (to offline) 2019-11-25 19:01:11 | [Mutex] received everything. 2019-11-25 19:01:11 | [Mutex] isItemNotified: node_v1iszb0184:subscribe_node:success :: true 2019-11-25 19:01:11 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-25 19:01:11 | command: <data><node>node_v1iszb0184</node><expire-at>2019-11-26T03:01:16Z</expire-at><entry><content>content_knzsl50188</content></entry></data> 2019-11-25 19:01:11 | target: http://localhost:8088 2019-11-25 19:01:11 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2019-11-25 19:01:11 | entity: <data><node>node_v1iszb0184</node><expire-at>2019-11-26T03:01:16Z</expire-at><entry><content>content_knzsl50188</content></entry></data> 2019-11-25 19:01:11 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 26 Nov 2019 03:01:11 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-25 19:01:11 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>6c93d709-473c-4a62-935d-084820c59e9e</value></item-id></result> 2019-11-25 19:01:11 | contains: true 2019-11-25 19:01:19 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-25 19:01:19 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=458 thread=1] DNS entry stored in session object: localhost:5222 2019-11-25 19:01:19 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=458 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-25 19:01:19 | [Mutex] waiting for: [user_regularrln0sr0183@localhost:message:received:content_knzsl50188] 2019-11-25 19:01:19 | [Mutex] waiting for: [user_regularrln0sr0183@localhost:message:received:content_knzsl50188] 2019-11-25 19:01:34 | [Mutex] timeout. Not received [user_regularrln0sr0183@localhost:message:received:content_knzsl50188] 2019-11-25 19:01:34 | [Mutex] received everything. 2019-11-25 19:01:34 | [Mutex] isItemNotified: user_regularrln0sr0183@localhost:message:received:content_knzsl50188 :: false 2019-11-25 19:01:34 | [Mutex] isItemNotified: admin@localhost:message:received:content_knzsl50188 :: true |