Generated by TestNG with ReportNG at 22:18 PDT on Saturday 25 June 2022
root@21fb2cc9076b / Java 17.0.2 (Private Build) / Linux 4.14.186-146.268.amzn2.x86_64 (amd64)

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

Suites · Log Output

Test duration : 44.644s

Passed Tests
tigase.tests.pubsub.TestRestApiWithMessageExpiration
testMessageExpiration 43.678s
2022-06-25 22:33:35 |

2022-06-25 22:33:35 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration]

2022-06-25 22:33:35 | ------------------------------------

2022-06-25 22:33:35 | [Mutex] isItemNotified: node_hzo6vp0204:exists :: false

2022-06-25 22:33:35 | [Mutex] waiting for: [node_hzo6vp0204:create_node]

2022-06-25 22:33:35 | [Mutex] waiting for: [node_hzo6vp0204:create_node]

2022-06-25 22:33:35 | [Mutex] received everything.

2022-06-25 22:33:35 | [Mutex] isItemNotified: node_hzo6vp0204:create_node:success :: true

2022-06-25 22:33:35 | [Mutex] waiting for: [node_hzo6vp0204:subscribe_node]

2022-06-25 22:33:35 | [Mutex] waiting for: [node_hzo6vp0204:subscribe_node]

2022-06-25 22:33:35 | [Mutex] received everything.

2022-06-25 22:33:35 | [Mutex] isItemNotified: node_hzo6vp0204:subscribe_node:success :: true

2022-06-25 22:33:35 |


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


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

2022-06-25 22:33:35 | command: <data><node>node_hzo6vp0204</node><entry><content>content_i8i4i0205</content></entry></data>

2022-06-25 22:33:35 | target: http://localhost:8088

2022-06-25 22:33:35 | entity: [Content-Type: application/xml,Content-Length: 92,Chunked: false]

2022-06-25 22:33:35 | entity: <data><node>node_hzo6vp0204</node><entry><content>content_i8i4i0205</content></entry></data>

2022-06-25 22:33:35 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sun, 26 Jun 2022 05:33:35 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-06-25 22:33:35 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>ce5fe829-97ff-400e-9ee2-23ede05322e5</value></item-id></result>

2022-06-25 22:33:35 | contains: true

2022-06-25 22:33:35 | [Mutex] received everything.

2022-06-25 22:33:35 | [Mutex] isItemNotified: user_regularqbtl40203@test-domain.com:message:received:content_i8i4i0205 :: true

2022-06-25 22:33:35 |


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


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

2022-06-25 22:33:35 | command: <data><node>node_hzo6vp0204</node><expire-at>2022-06-26T05:33:30Z</expire-at><entry><content>content_sle7730206</content></entry></data>

2022-06-25 22:33:35 | target: http://localhost:8088

2022-06-25 22:33:35 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-06-25 22:33:35 | entity: <data><node>node_hzo6vp0204</node><expire-at>2022-06-26T05:33:30Z</expire-at><entry><content>content_sle7730206</content></entry></data>

2022-06-25 22:33:35 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sun, 26 Jun 2022 05:33:35 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-06-25 22:33:35 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>dd2594a3-8d0b-479b-8e7f-a8bb1ef868a5</value></item-id></result>

2022-06-25 22:33:35 | contains: true

2022-06-25 22:33:35 | [Mutex] waiting for: [user_regularqbtl40203@test-domain.com:message:received:content_sle7730206]

2022-06-25 22:33:50 | [Mutex] timeout. Not received [user_regularqbtl40203@test-domain.com:message:received:content_sle7730206]

2022-06-25 22:33:50 | [Mutex] isItemNotified: user_regularqbtl40203@test-domain.com:message:received:content_sle7730206 :: false

2022-06-25 22:33:50 |


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


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

2022-06-25 22:33:50 | command: <data><node>node_hzo6vp0204</node><entry><content>content_v2x6sq0207</content></entry></data>

2022-06-25 22:33:50 | target: http://localhost:8088

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

2022-06-25 22:33:50 | entity: <data><node>node_hzo6vp0204</node><entry><content>content_v2x6sq0207</content></entry></data>

2022-06-25 22:33:50 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sun, 26 Jun 2022 05:33:50 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-06-25 22:33:50 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>6296b2c9-3ecf-4301-9f82-cc4445f139f9</value></item-id></result>

2022-06-25 22:33:50 | contains: true

2022-06-25 22:33:55 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2022-06-25 22:33:56 | [Mutex] waiting for: [user_regularqbtl40203@test-domain.com:message:received:content_v2x6sq0207]

2022-06-25 22:33:56 | [Mutex] received everything.

2022-06-25 22:33:56 | [Mutex] isItemNotified: user_regularqbtl40203@test-domain.com:message:received:content_v2x6sq0207 :: true

2022-06-25 22:33:56 |


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


2022-06-25 22:33:56 | [Mutex] received everything.

2022-06-25 22:33:56 | [Mutex] isItemNotified: node_hzo6vp0204:subscribe_node:success :: true

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

2022-06-25 22:33:56 | command: <data><node>node_hzo6vp0204</node><expire-at>2022-06-26T05:34:01Z</expire-at><entry><content>content_3xx01n0208</content></entry></data>

2022-06-25 22:33:56 | target: http://localhost:8088

2022-06-25 22:33:56 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-06-25 22:33:56 | entity: <data><node>node_hzo6vp0204</node><expire-at>2022-06-26T05:34:01Z</expire-at><entry><content>content_3xx01n0208</content></entry></data>

2022-06-25 22:33:56 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sun, 26 Jun 2022 05:33:56 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-06-25 22:33:56 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>34d8266b-4ad0-49ab-b924-07abf24e45d8</value></item-id></result>

2022-06-25 22:33:56 | contains: true

2022-06-25 22:34:04 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2022-06-25 22:34:04 | [Mutex] waiting for: [user_regularqbtl40203@test-domain.com:message:received:content_3xx01n0208]

2022-06-25 22:34:04 | [Mutex] waiting for: [user_regularqbtl40203@test-domain.com:message:received:content_3xx01n0208]

2022-06-25 22:34:19 | [Mutex] timeout. Not received [user_regularqbtl40203@test-domain.com:message:received:content_3xx01n0208]

2022-06-25 22:34:19 | [Mutex] received everything.

2022-06-25 22:34:19 | [Mutex] isItemNotified: user_regularqbtl40203@test-domain.com:message:received:content_3xx01n0208 :: false

2022-06-25 22:34:19 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_3xx01n0208 :: true