Generated by TestNG with ReportNG at 22:18 PDT on Monday 25 July 2022
root@f9c07ffec79b / 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.838s

Passed Tests
tigase.tests.pubsub.TestRestApiWithMessageExpiration
testMessageExpiration 43.602s
2022-07-25 22:32:21 |

2022-07-25 22:32:21 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration]

2022-07-25 22:32:21 | ------------------------------------

2022-07-25 22:32:21 | [Mutex] isItemNotified: node_ose5350204:exists :: false

2022-07-25 22:32:21 | [Mutex] waiting for: [node_ose5350204:create_node]

2022-07-25 22:32:22 | [Mutex] waiting for: [node_ose5350204:create_node]

2022-07-25 22:32:22 | [Mutex] received everything.

2022-07-25 22:32:22 | [Mutex] isItemNotified: node_ose5350204:create_node:success :: true

2022-07-25 22:32:22 | [Mutex] waiting for: [node_ose5350204:subscribe_node]

2022-07-25 22:32:22 | [Mutex] waiting for: [node_ose5350204:subscribe_node]

2022-07-25 22:32:22 | [Mutex] received everything.

2022-07-25 22:32:22 | [Mutex] isItemNotified: node_ose5350204:subscribe_node:success :: true

2022-07-25 22:32:22 |


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


2022-07-25 22:32:22 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-25 22:32:22 | command: <data><node>node_ose5350204</node><entry><content>content_ve4pc00205</content></entry></data>

2022-07-25 22:32:22 | target: http://localhost:8088

2022-07-25 22:32:22 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-07-25 22:32:22 | entity: <data><node>node_ose5350204</node><entry><content>content_ve4pc00205</content></entry></data>

2022-07-25 22:32:22 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 26 Jul 2022 05:32:22 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-25 22:32:22 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>d4d9c066-7408-48c7-8b73-ef71fcd0c512</value></item-id></result>

2022-07-25 22:32:22 | contains: true

2022-07-25 22:32:22 | [Mutex] received everything.

2022-07-25 22:32:22 | [Mutex] isItemNotified: user_regular1m4xrk0203@test-domain.com:message:received:content_ve4pc00205 :: true

2022-07-25 22:32:22 |


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


2022-07-25 22:32:22 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-25 22:32:22 | command: <data><node>node_ose5350204</node><expire-at>2022-07-26T05:32:17Z</expire-at><entry><content>content_6nflnn0206</content></entry></data>

2022-07-25 22:32:22 | target: http://localhost:8088

2022-07-25 22:32:22 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-07-25 22:32:22 | entity: <data><node>node_ose5350204</node><expire-at>2022-07-26T05:32:17Z</expire-at><entry><content>content_6nflnn0206</content></entry></data>

2022-07-25 22:32:22 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 26 Jul 2022 05:32:22 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-25 22:32:22 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>bd2f89d4-b2c1-4add-9def-c034f5c20a00</value></item-id></result>

2022-07-25 22:32:22 | contains: true

2022-07-25 22:32:22 | [Mutex] waiting for: [user_regular1m4xrk0203@test-domain.com:message:received:content_6nflnn0206]

2022-07-25 22:32:37 | [Mutex] timeout. Not received [user_regular1m4xrk0203@test-domain.com:message:received:content_6nflnn0206]

2022-07-25 22:32:37 | [Mutex] isItemNotified: user_regular1m4xrk0203@test-domain.com:message:received:content_6nflnn0206 :: false

2022-07-25 22:32:37 |


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


2022-07-25 22:32:37 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-25 22:32:37 | command: <data><node>node_ose5350204</node><entry><content>content_881o5c0207</content></entry></data>

2022-07-25 22:32:37 | target: http://localhost:8088

2022-07-25 22:32:37 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-07-25 22:32:37 | entity: <data><node>node_ose5350204</node><entry><content>content_881o5c0207</content></entry></data>

2022-07-25 22:32:37 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 26 Jul 2022 05:32:37 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-25 22:32:37 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>c9aefc79-d357-498e-8a76-82a278f82d1f</value></item-id></result>

2022-07-25 22:32:37 | contains: true

2022-07-25 22:32:42 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2022-07-25 22:32:42 | [Mutex] waiting for: [user_regular1m4xrk0203@test-domain.com:message:received:content_881o5c0207]

2022-07-25 22:32:42 | [Mutex] received everything.

2022-07-25 22:32:42 | [Mutex] isItemNotified: user_regular1m4xrk0203@test-domain.com:message:received:content_881o5c0207 :: true

2022-07-25 22:32:42 |


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


2022-07-25 22:32:42 | [Mutex] received everything.

2022-07-25 22:32:42 | [Mutex] isItemNotified: node_ose5350204:subscribe_node:success :: true

2022-07-25 22:32:42 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-25 22:32:42 | command: <data><node>node_ose5350204</node><expire-at>2022-07-26T05:32:47Z</expire-at><entry><content>content_5jc9m50208</content></entry></data>

2022-07-25 22:32:42 | target: http://localhost:8088

2022-07-25 22:32:42 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-07-25 22:32:42 | entity: <data><node>node_ose5350204</node><expire-at>2022-07-26T05:32:47Z</expire-at><entry><content>content_5jc9m50208</content></entry></data>

2022-07-25 22:32:42 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 26 Jul 2022 05:32:42 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-25 22:32:42 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>9bf659f8-802c-49a6-9b83-18b810d6d245</value></item-id></result>

2022-07-25 22:32:42 | contains: true

2022-07-25 22:32:50 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2022-07-25 22:32:50 | [Mutex] waiting for: [user_regular1m4xrk0203@test-domain.com:message:received:content_5jc9m50208]

2022-07-25 22:32:50 | [Mutex] waiting for: [user_regular1m4xrk0203@test-domain.com:message:received:content_5jc9m50208]

2022-07-25 22:33:05 | [Mutex] timeout. Not received [user_regular1m4xrk0203@test-domain.com:message:received:content_5jc9m50208]

2022-07-25 22:33:05 | [Mutex] received everything.

2022-07-25 22:33:05 | [Mutex] isItemNotified: user_regular1m4xrk0203@test-domain.com:message:received:content_5jc9m50208 :: false

2022-07-25 22:33:05 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_5jc9m50208 :: true