Test duration : 44.726s
| Passed Tests | ||
|---|---|---|
| tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
| testMessageExpiration | 43.561s |
2022-06-19 22:39:35 |
2022-06-19 22:39:35 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2022-06-19 22:39:35 | ------------------------------------ 2022-06-19 22:39:35 | [Mutex] isItemNotified: node_ovh5ln0204:exists :: false 2022-06-19 22:39:35 | [Mutex] waiting for: [node_ovh5ln0204:create_node] 2022-06-19 22:39:35 | [Mutex] received everything. 2022-06-19 22:39:35 | [Mutex] isItemNotified: node_ovh5ln0204:create_node:success :: true 2022-06-19 22:39:35 | [Mutex] waiting for: [node_ovh5ln0204:subscribe_node] 2022-06-19 22:39:35 | [Mutex] waiting for: [node_ovh5ln0204:subscribe_node] 2022-06-19 22:39:35 | [Mutex] received everything. 2022-06-19 22:39:35 | [Mutex] isItemNotified: node_ovh5ln0204:subscribe_node:success :: true 2022-06-19 22:39:35 | ===== publishing normal message (to online) 2022-06-19 22:39:35 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-06-19 22:39:35 | command: <data><node>node_ovh5ln0204</node><entry><content>content_lusazp0205</content></entry></data> 2022-06-19 22:39:35 | target: http://localhost:8088 2022-06-19 22:39:35 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-06-19 22:39:35 | entity: <data><node>node_ovh5ln0204</node><entry><content>content_lusazp0205</content></entry></data> 2022-06-19 22:39:36 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Mon, 20 Jun 2022 05:39:36 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-06-19 22:39:36 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>4b0ae6c5-11f4-4ef1-9be9-f76732394a73</value></item-id></result> 2022-06-19 22:39:36 | contains: true 2022-06-19 22:39:36 | [Mutex] received everything. 2022-06-19 22:39:36 | [Mutex] isItemNotified: user_regularugcb240203@test-domain.com:message:received:content_lusazp0205 :: true 2022-06-19 22:39:36 | ===== publishing already old message - expecting message being filtered out (to online) 2022-06-19 22:39:36 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-06-19 22:39:36 | command: <data><node>node_ovh5ln0204</node><expire-at>2022-06-20T05:39:31Z</expire-at><entry><content>content_igb5dl0206</content></entry></data> 2022-06-19 22:39:36 | target: http://localhost:8088 2022-06-19 22:39:36 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-06-19 22:39:36 | entity: <data><node>node_ovh5ln0204</node><expire-at>2022-06-20T05:39:31Z</expire-at><entry><content>content_igb5dl0206</content></entry></data> 2022-06-19 22:39:36 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Mon, 20 Jun 2022 05:39:36 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-06-19 22:39:36 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>32b65f33-d9b5-4086-bc2a-d1d7367fcd9d</value></item-id></result> 2022-06-19 22:39:36 | contains: true 2022-06-19 22:39:36 | [Mutex] waiting for: [user_regularugcb240203@test-domain.com:message:received:content_igb5dl0206] 2022-06-19 22:39:51 | [Mutex] timeout. Not received [user_regularugcb240203@test-domain.com:message:received:content_igb5dl0206] 2022-06-19 22:39:51 | [Mutex] isItemNotified: user_regularugcb240203@test-domain.com:message:received:content_igb5dl0206 :: false 2022-06-19 22:39:51 | ===== publishing normal message (to offline) 2022-06-19 22:39:51 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-06-19 22:39:51 | command: <data><node>node_ovh5ln0204</node><entry><content>content_ta89zd0207</content></entry></data> 2022-06-19 22:39:51 | target: http://localhost:8088 2022-06-19 22:39:51 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-06-19 22:39:51 | entity: <data><node>node_ovh5ln0204</node><entry><content>content_ta89zd0207</content></entry></data> 2022-06-19 22:39:51 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Mon, 20 Jun 2022 05:39:51 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-06-19 22:39:51 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>07a7a375-d643-4c2f-86cb-8e1b2029179b</value></item-id></result> 2022-06-19 22:39:51 | contains: true 2022-06-19 22:39:56 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-06-19 22:39:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] DNS entry stored in session object: localhost:5222 2022-06-19 22:39:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-06-19 22:39:56 | [Mutex] waiting for: [user_regularugcb240203@test-domain.com:message:received:content_ta89zd0207] 2022-06-19 22:39:56 | [Mutex] received everything. 2022-06-19 22:39:56 | [Mutex] isItemNotified: user_regularugcb240203@test-domain.com:message:received:content_ta89zd0207 :: true 2022-06-19 22:39:56 | ===== publishing already old message - expecting message being filtered out (to offline) 2022-06-19 22:39:56 | [Mutex] received everything. 2022-06-19 22:39:56 | [Mutex] isItemNotified: node_ovh5ln0204:subscribe_node:success :: true 2022-06-19 22:39:56 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-06-19 22:39:56 | command: <data><node>node_ovh5ln0204</node><expire-at>2022-06-20T05:40:01Z</expire-at><entry><content>content_lzb46n0208</content></entry></data> 2022-06-19 22:39:56 | target: http://localhost:8088 2022-06-19 22:39:56 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-06-19 22:39:56 | entity: <data><node>node_ovh5ln0204</node><expire-at>2022-06-20T05:40:01Z</expire-at><entry><content>content_lzb46n0208</content></entry></data> 2022-06-19 22:39:56 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Mon, 20 Jun 2022 05:39:56 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-06-19 22:39:56 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>aea1ee83-75ac-4c86-9555-011f576213ff</value></item-id></result> 2022-06-19 22:39:56 | contains: true 2022-06-19 22:40:04 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-06-19 22:40:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222 2022-06-19 22:40:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-06-19 22:40:04 | [Mutex] waiting for: [user_regularugcb240203@test-domain.com:message:received:content_lzb46n0208] 2022-06-19 22:40:19 | [Mutex] timeout. Not received [user_regularugcb240203@test-domain.com:message:received:content_lzb46n0208] 2022-06-19 22:40:19 | [Mutex] received everything. 2022-06-19 22:40:19 | [Mutex] isItemNotified: user_regularugcb240203@test-domain.com:message:received:content_lzb46n0208 :: false 2022-06-19 22:40:19 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_lzb46n0208 :: true |