Generated by TestNG with ReportNG at 22:30 PDT on Wednesday 06 July 2022
root@7c41cec37518 / Java 17.0.2 (Private Build) / Linux 4.14.281-212.502.amzn2.x86_64 (amd64)

REST: Item publication on PubSub node with message expiration using REST API - #2959

Suites · Log Output

Test duration : 44.956s

Passed Tests
tigase.tests.pubsub.TestRestApiWithMessageExpiration
testMessageExpiration 43.705s
2022-07-06 22:46:18 |

2022-07-06 22:46:18 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration]

2022-07-06 22:46:18 | ------------------------------------

2022-07-06 22:46:18 | [Mutex] isItemNotified: node_rbq6iu0204:exists :: false

2022-07-06 22:46:18 | [Mutex] waiting for: [node_rbq6iu0204:create_node]

2022-07-06 22:46:18 | [Mutex] received everything.

2022-07-06 22:46:18 | [Mutex] isItemNotified: node_rbq6iu0204:create_node:success :: true

2022-07-06 22:46:18 | [Mutex] waiting for: [node_rbq6iu0204:subscribe_node]

2022-07-06 22:46:18 | [Mutex] waiting for: [node_rbq6iu0204:subscribe_node]

2022-07-06 22:46:18 | [Mutex] received everything.

2022-07-06 22:46:18 | [Mutex] isItemNotified: node_rbq6iu0204:subscribe_node:success :: true

2022-07-06 22:46:18 |


===== publishing normal message (to online)


2022-07-06 22:46:18 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-06 22:46:18 | command: <data><node>node_rbq6iu0204</node><entry><content>content_4w1a9n0205</content></entry></data>

2022-07-06 22:46:18 | target: http://localhost:8088

2022-07-06 22:46:18 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-07-06 22:46:18 | entity: <data><node>node_rbq6iu0204</node><entry><content>content_4w1a9n0205</content></entry></data>

2022-07-06 22:46:18 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 07 Jul 2022 05:46:18 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-06 22:46:18 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>79bbc0d4-fb91-47ad-aa0a-0dafaf28c454</value></item-id></result>

2022-07-06 22:46:18 | contains: true

2022-07-06 22:46:18 | [Mutex] waiting for: [user_regularat79cx0203@test-domain.com:message:received:content_4w1a9n0205]

2022-07-06 22:46:18 | [Mutex] received everything.

2022-07-06 22:46:18 | [Mutex] isItemNotified: user_regularat79cx0203@test-domain.com:message:received:content_4w1a9n0205 :: true

2022-07-06 22:46:18 |


===== publishing already old message - expecting message being filtered out (to online)


2022-07-06 22:46:18 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-06 22:46:18 | command: <data><node>node_rbq6iu0204</node><expire-at>2022-07-07T05:46:13Z</expire-at><entry><content>content_r4qlc90206</content></entry></data>

2022-07-06 22:46:18 | target: http://localhost:8088

2022-07-06 22:46:18 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-07-06 22:46:18 | entity: <data><node>node_rbq6iu0204</node><expire-at>2022-07-07T05:46:13Z</expire-at><entry><content>content_r4qlc90206</content></entry></data>

2022-07-06 22:46:18 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 07 Jul 2022 05:46:18 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-06 22:46:18 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>159170f2-f896-4739-91f6-f431908cb971</value></item-id></result>

2022-07-06 22:46:18 | contains: true

2022-07-06 22:46:18 | [Mutex] waiting for: [user_regularat79cx0203@test-domain.com:message:received:content_r4qlc90206]

2022-07-06 22:46:33 | [Mutex] timeout. Not received [user_regularat79cx0203@test-domain.com:message:received:content_r4qlc90206]

2022-07-06 22:46:33 | [Mutex] isItemNotified: user_regularat79cx0203@test-domain.com:message:received:content_r4qlc90206 :: false

2022-07-06 22:46:33 |


===== publishing normal message (to offline)


2022-07-06 22:46:33 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-06 22:46:33 | command: <data><node>node_rbq6iu0204</node><entry><content>content_k1s9em0207</content></entry></data>

2022-07-06 22:46:33 | target: http://localhost:8088

2022-07-06 22:46:33 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-07-06 22:46:33 | entity: <data><node>node_rbq6iu0204</node><entry><content>content_k1s9em0207</content></entry></data>

2022-07-06 22:46:33 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 07 Jul 2022 05:46:33 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-06 22:46:33 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>2ff03499-c60f-4919-ac60-650b669d5c90</value></item-id></result>

2022-07-06 22:46:33 | contains: true

2022-07-06 22:46:38 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-07-06 22:46:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] DNS entry stored in session object: localhost:5222

2022-07-06 22:46:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-07-06 22:46:39 | [Mutex] waiting for: [user_regularat79cx0203@test-domain.com:message:received:content_k1s9em0207]

2022-07-06 22:46:39 | [Mutex] waiting for: [user_regularat79cx0203@test-domain.com:message:received:content_k1s9em0207]

2022-07-06 22:46:39 | [Mutex] received everything.

2022-07-06 22:46:39 | [Mutex] isItemNotified: user_regularat79cx0203@test-domain.com:message:received:content_k1s9em0207 :: true

2022-07-06 22:46:39 |


===== publishing already old message - expecting message being filtered out (to offline)


2022-07-06 22:46:39 | [Mutex] received everything.

2022-07-06 22:46:39 | [Mutex] isItemNotified: node_rbq6iu0204:subscribe_node:success :: true

2022-07-06 22:46:39 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-06 22:46:39 | command: <data><node>node_rbq6iu0204</node><expire-at>2022-07-07T05:46:44Z</expire-at><entry><content>content_b1k8gv0208</content></entry></data>

2022-07-06 22:46:39 | target: http://localhost:8088

2022-07-06 22:46:39 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-07-06 22:46:39 | entity: <data><node>node_rbq6iu0204</node><expire-at>2022-07-07T05:46:44Z</expire-at><entry><content>content_b1k8gv0208</content></entry></data>

2022-07-06 22:46:39 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 07 Jul 2022 05:46:39 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-06 22:46:39 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>1fdfbd5f-8fb3-45b9-996c-c99835c1749e</value></item-id></result>

2022-07-06 22:46:39 | contains: true

2022-07-06 22:46:47 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-07-06 22:46:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222

2022-07-06 22:46:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-07-06 22:46:47 | [Mutex] waiting for: [user_regularat79cx0203@test-domain.com:message:received:content_b1k8gv0208]

2022-07-06 22:46:47 | [Mutex] waiting for: [user_regularat79cx0203@test-domain.com:message:received:content_b1k8gv0208]

2022-07-06 22:47:02 | [Mutex] timeout. Not received [user_regularat79cx0203@test-domain.com:message:received:content_b1k8gv0208]

2022-07-06 22:47:02 | [Mutex] received everything.

2022-07-06 22:47:02 | [Mutex] isItemNotified: user_regularat79cx0203@test-domain.com:message:received:content_b1k8gv0208 :: false

2022-07-06 22:47:02 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_b1k8gv0208 :: true