Generated by TestNG with ReportNG at 22:36 PDT on Wednesday 27 April 2022
root@1bc69cf4cb94 / 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.936s

Passed Tests
tigase.tests.pubsub.TestRestApiWithMessageExpiration
testMessageExpiration 43.696s
2022-04-27 22:52:00 |

2022-04-27 22:52:00 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration]

2022-04-27 22:52:00 | ------------------------------------

2022-04-27 22:52:00 | [Mutex] isItemNotified: node_4w4svj0204:exists :: false

2022-04-27 22:52:00 | [Mutex] waiting for: [node_4w4svj0204:create_node]

2022-04-27 22:52:00 | [Mutex] received everything.

2022-04-27 22:52:00 | [Mutex] isItemNotified: node_4w4svj0204:create_node:success :: true

2022-04-27 22:52:00 | [Mutex] waiting for: [node_4w4svj0204:subscribe_node]

2022-04-27 22:52:00 | [Mutex] received everything.

2022-04-27 22:52:00 | [Mutex] isItemNotified: node_4w4svj0204:subscribe_node:success :: true

2022-04-27 22:52:00 |


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


2022-04-27 22:52:00 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-04-27 22:52:00 | command: <data><node>node_4w4svj0204</node><entry><content>content_g51tow0205</content></entry></data>

2022-04-27 22:52:00 | target: http://localhost:8088

2022-04-27 22:52:00 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-04-27 22:52:00 | entity: <data><node>node_4w4svj0204</node><entry><content>content_g51tow0205</content></entry></data>

2022-04-27 22:52:00 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 28 Apr 2022 05:52:00 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-04-27 22:52:00 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>15a0547b-78f2-48b5-9d11-33fc77b49dc9</value></item-id></result>

2022-04-27 22:52:00 | contains: true

2022-04-27 22:52:00 | [Mutex] received everything.

2022-04-27 22:52:00 | [Mutex] isItemNotified: user_regulard32wr80203@test-domain.com:message:received:content_g51tow0205 :: true

2022-04-27 22:52:00 |


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


2022-04-27 22:52:00 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-04-27 22:52:00 | command: <data><node>node_4w4svj0204</node><expire-at>2022-04-28T05:51:55Z</expire-at><entry><content>content_wekpdn0206</content></entry></data>

2022-04-27 22:52:00 | target: http://localhost:8088

2022-04-27 22:52:00 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-04-27 22:52:00 | entity: <data><node>node_4w4svj0204</node><expire-at>2022-04-28T05:51:55Z</expire-at><entry><content>content_wekpdn0206</content></entry></data>

2022-04-27 22:52:00 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 28 Apr 2022 05:52:00 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-04-27 22:52:00 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>29a3ab46-c883-4c93-8836-5a44b79eeb07</value></item-id></result>

2022-04-27 22:52:00 | contains: true

2022-04-27 22:52:00 | [Mutex] waiting for: [user_regulard32wr80203@test-domain.com:message:received:content_wekpdn0206]

2022-04-27 22:52:15 | [Mutex] timeout. Not received [user_regulard32wr80203@test-domain.com:message:received:content_wekpdn0206]

2022-04-27 22:52:15 | [Mutex] isItemNotified: user_regulard32wr80203@test-domain.com:message:received:content_wekpdn0206 :: false

2022-04-27 22:52:15 |


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


2022-04-27 22:52:15 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-04-27 22:52:15 | command: <data><node>node_4w4svj0204</node><entry><content>content_18hvh90207</content></entry></data>

2022-04-27 22:52:15 | target: http://localhost:8088

2022-04-27 22:52:15 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-04-27 22:52:15 | entity: <data><node>node_4w4svj0204</node><entry><content>content_18hvh90207</content></entry></data>

2022-04-27 22:52:15 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 28 Apr 2022 05:52:15 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-04-27 22:52:15 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>e37c1484-380d-44b3-942e-d98d0815cc0f</value></item-id></result>

2022-04-27 22:52:15 | contains: true

2022-04-27 22:52:20 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

2022-04-27 22:52:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-04-27 22:52:20 | [Mutex] waiting for: [user_regulard32wr80203@test-domain.com:message:received:content_18hvh90207]

2022-04-27 22:52:20 | [Mutex] waiting for: [user_regulard32wr80203@test-domain.com:message:received:content_18hvh90207]

2022-04-27 22:52:20 | [Mutex] received everything.

2022-04-27 22:52:20 | [Mutex] isItemNotified: user_regulard32wr80203@test-domain.com:message:received:content_18hvh90207 :: true

2022-04-27 22:52:20 |


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


2022-04-27 22:52:20 | [Mutex] received everything.

2022-04-27 22:52:20 | [Mutex] isItemNotified: node_4w4svj0204:subscribe_node:success :: true

2022-04-27 22:52:20 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-04-27 22:52:20 | command: <data><node>node_4w4svj0204</node><expire-at>2022-04-28T05:52:25Z</expire-at><entry><content>content_48p03e0208</content></entry></data>

2022-04-27 22:52:20 | target: http://localhost:8088

2022-04-27 22:52:20 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-04-27 22:52:20 | entity: <data><node>node_4w4svj0204</node><expire-at>2022-04-28T05:52:25Z</expire-at><entry><content>content_48p03e0208</content></entry></data>

2022-04-27 22:52:20 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 28 Apr 2022 05:52:20 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-04-27 22:52:20 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>48cc0e6e-f684-4648-8fbb-c94fb76709bb</value></item-id></result>

2022-04-27 22:52:20 | contains: true

2022-04-27 22:52:28 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2022-04-27 22:52:28 | [Mutex] waiting for: [user_regulard32wr80203@test-domain.com:message:received:content_48p03e0208]

2022-04-27 22:52:28 | [Mutex] waiting for: [user_regulard32wr80203@test-domain.com:message:received:content_48p03e0208]

2022-04-27 22:52:28 | [Mutex] waiting for: [user_regulard32wr80203@test-domain.com:message:received:content_48p03e0208]

2022-04-27 22:52:43 | [Mutex] timeout. Not received [user_regulard32wr80203@test-domain.com:message:received:content_48p03e0208]

2022-04-27 22:52:43 | [Mutex] received everything.

2022-04-27 22:52:43 | [Mutex] isItemNotified: user_regulard32wr80203@test-domain.com:message:received:content_48p03e0208 :: false

2022-04-27 22:52:43 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_48p03e0208 :: true