Generated by TestNG with ReportNG at 22:46 PDT on Friday 22 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.608s

Passed Tests
tigase.tests.pubsub.TestRestApiWithMessageExpiration
testMessageExpiration 43.649s
2022-07-22 23:00:41 |

2022-07-22 23:00:41 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration]

2022-07-22 23:00:41 | ------------------------------------

2022-07-22 23:00:41 | [Mutex] isItemNotified: node_z4j4vi0204:exists :: false

2022-07-22 23:00:41 | [Mutex] waiting for: [node_z4j4vi0204:create_node]

2022-07-22 23:00:41 | [Mutex] received everything.

2022-07-22 23:00:41 | [Mutex] isItemNotified: node_z4j4vi0204:create_node:success :: true

2022-07-22 23:00:41 | [Mutex] waiting for: [node_z4j4vi0204:subscribe_node]

2022-07-22 23:00:41 | [Mutex] waiting for: [node_z4j4vi0204:subscribe_node]

2022-07-22 23:00:41 | [Mutex] received everything.

2022-07-22 23:00:41 | [Mutex] isItemNotified: node_z4j4vi0204:subscribe_node:success :: true

2022-07-22 23:00:41 |


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


2022-07-22 23:00:41 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-22 23:00:41 | command: <data><node>node_z4j4vi0204</node><entry><content>content_eh29z60205</content></entry></data>

2022-07-22 23:00:41 | target: http://localhost:8088

2022-07-22 23:00:41 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-07-22 23:00:41 | entity: <data><node>node_z4j4vi0204</node><entry><content>content_eh29z60205</content></entry></data>

2022-07-22 23:00:41 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sat, 23 Jul 2022 06:00:41 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-22 23:00:41 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>c140064e-08e2-495d-87bc-25b267cc922d</value></item-id></result>

2022-07-22 23:00:41 | contains: true

2022-07-22 23:00:41 | [Mutex] waiting for: [user_regular580eil0203@test-domain.com:message:received:content_eh29z60205]

2022-07-22 23:00:41 | [Mutex] received everything.

2022-07-22 23:00:41 | [Mutex] isItemNotified: user_regular580eil0203@test-domain.com:message:received:content_eh29z60205 :: true

2022-07-22 23:00:41 |


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


2022-07-22 23:00:41 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-22 23:00:41 | command: <data><node>node_z4j4vi0204</node><expire-at>2022-07-23T06:00:36Z</expire-at><entry><content>content_24hpu00206</content></entry></data>

2022-07-22 23:00:41 | target: http://localhost:8088

2022-07-22 23:00:41 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-07-22 23:00:41 | entity: <data><node>node_z4j4vi0204</node><expire-at>2022-07-23T06:00:36Z</expire-at><entry><content>content_24hpu00206</content></entry></data>

2022-07-22 23:00:41 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sat, 23 Jul 2022 06:00:41 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-22 23:00:41 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>f07ecf33-5bce-44e5-9b89-72e05eb61763</value></item-id></result>

2022-07-22 23:00:41 | contains: true

2022-07-22 23:00:41 | [Mutex] waiting for: [user_regular580eil0203@test-domain.com:message:received:content_24hpu00206]

2022-07-22 23:00:56 | [Mutex] timeout. Not received [user_regular580eil0203@test-domain.com:message:received:content_24hpu00206]

2022-07-22 23:00:56 | [Mutex] isItemNotified: user_regular580eil0203@test-domain.com:message:received:content_24hpu00206 :: false

2022-07-22 23:00:56 |


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


2022-07-22 23:00:56 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-07-22 23:00:56 | command: <data><node>node_z4j4vi0204</node><entry><content>content_6gup1h0207</content></entry></data>

2022-07-22 23:00:56 | target: http://localhost:8088

2022-07-22 23:00:56 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-07-22 23:00:56 | entity: <data><node>node_z4j4vi0204</node><entry><content>content_6gup1h0207</content></entry></data>

2022-07-22 23:00:56 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sat, 23 Jul 2022 06:00:56 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-07-22 23:00:56 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>9cf733fb-f39d-4321-aad9-1c082d0c0eaf</value></item-id></result>

2022-07-22 23:00:56 | contains: true

2022-07-22 23:01:01 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2022-07-22 23:01:01 | [Mutex] waiting for: [user_regular580eil0203@test-domain.com:message:received:content_6gup1h0207]

2022-07-22 23:01:01 | [Mutex] received everything.

2022-07-22 23:01:01 | [Mutex] isItemNotified: user_regular580eil0203@test-domain.com:message:received:content_6gup1h0207 :: true

2022-07-22 23:01:01 |


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


2022-07-22 23:01:01 | [Mutex] received everything.

2022-07-22 23:01:01 | [Mutex] isItemNotified: node_z4j4vi0204:subscribe_node:success :: true

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

2022-07-22 23:01:01 | command: <data><node>node_z4j4vi0204</node><expire-at>2022-07-23T06:01:06Z</expire-at><entry><content>content_5xfpkt0208</content></entry></data>

2022-07-22 23:01:01 | target: http://localhost:8088

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

2022-07-22 23:01:01 | entity: <data><node>node_z4j4vi0204</node><expire-at>2022-07-23T06:01:06Z</expire-at><entry><content>content_5xfpkt0208</content></entry></data>

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

2022-07-22 23:01:01 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>5a66ee53-1b40-43ff-8b2e-4a4f3712067a</value></item-id></result>

2022-07-22 23:01:01 | contains: true

2022-07-22 23:01:09 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2022-07-22 23:01:09 | [Mutex] waiting for: [user_regular580eil0203@test-domain.com:message:received:content_5xfpkt0208]

2022-07-22 23:01:09 | [Mutex] waiting for: [user_regular580eil0203@test-domain.com:message:received:content_5xfpkt0208]

2022-07-22 23:01:09 | [Mutex] waiting for: [user_regular580eil0203@test-domain.com:message:received:content_5xfpkt0208]

2022-07-22 23:01:24 | [Mutex] timeout. Not received [user_regular580eil0203@test-domain.com:message:received:content_5xfpkt0208]

2022-07-22 23:01:24 | [Mutex] received everything.

2022-07-22 23:01:24 | [Mutex] isItemNotified: user_regular580eil0203@test-domain.com:message:received:content_5xfpkt0208 :: false

2022-07-22 23:01:24 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_5xfpkt0208 :: true