Generated by TestNG with ReportNG at 04:13 PDT on Tuesday 25 October 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.526s

Passed Tests
tigase.tests.pubsub.TestRestApiWithMessageExpiration
testMessageExpiration 43.637s
2022-10-25 04:34:00 |

2022-10-25 04:34:00 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration]

2022-10-25 04:34:00 | ------------------------------------

2022-10-25 04:34:00 | [Mutex] isItemNotified: node_25ts1s0204:exists :: false

2022-10-25 04:34:00 | [Mutex] waiting for: [node_25ts1s0204:create_node]

2022-10-25 04:34:00 | [Mutex] received everything.

2022-10-25 04:34:00 | [Mutex] isItemNotified: node_25ts1s0204:create_node:success :: true

2022-10-25 04:34:00 | [Mutex] waiting for: [node_25ts1s0204:subscribe_node]

2022-10-25 04:34:00 | [Mutex] waiting for: [node_25ts1s0204:subscribe_node]

2022-10-25 04:34:00 | [Mutex] received everything.

2022-10-25 04:34:00 | [Mutex] isItemNotified: node_25ts1s0204:subscribe_node:success :: true

2022-10-25 04:34:00 |


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


2022-10-25 04:34:00 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-10-25 04:34:00 | command: <data><node>node_25ts1s0204</node><entry><content>content_6osi8o0205</content></entry></data>

2022-10-25 04:34:00 | target: http://localhost:8088

2022-10-25 04:34:00 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-10-25 04:34:00 | entity: <data><node>node_25ts1s0204</node><entry><content>content_6osi8o0205</content></entry></data>

2022-10-25 04:34:00 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 25 Oct 2022 11:34:00 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-10-25 04:34:00 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>6956e08d-781f-4e06-b0a7-43dfb293d254</value></item-id></result>

2022-10-25 04:34:00 | contains: true

2022-10-25 04:34:00 | [Mutex] waiting for: [user_regularv3rg170203@test-domain.com:message:received:content_6osi8o0205]

2022-10-25 04:34:00 | [Mutex] received everything.

2022-10-25 04:34:00 | [Mutex] isItemNotified: user_regularv3rg170203@test-domain.com:message:received:content_6osi8o0205 :: true

2022-10-25 04:34:00 |


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


2022-10-25 04:34:00 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-10-25 04:34:00 | command: <data><node>node_25ts1s0204</node><expire-at>2022-10-25T11:33:55Z</expire-at><entry><content>content_29uw5z0206</content></entry></data>

2022-10-25 04:34:00 | target: http://localhost:8088

2022-10-25 04:34:00 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-10-25 04:34:00 | entity: <data><node>node_25ts1s0204</node><expire-at>2022-10-25T11:33:55Z</expire-at><entry><content>content_29uw5z0206</content></entry></data>

2022-10-25 04:34:00 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 25 Oct 2022 11:34:00 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-10-25 04:34:00 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>1818d89e-c886-4e38-ba5d-e7723da3c797</value></item-id></result>

2022-10-25 04:34:00 | contains: true

2022-10-25 04:34:00 | [Mutex] waiting for: [user_regularv3rg170203@test-domain.com:message:received:content_29uw5z0206]

2022-10-25 04:34:15 | [Mutex] timeout. Not received [user_regularv3rg170203@test-domain.com:message:received:content_29uw5z0206]

2022-10-25 04:34:15 | [Mutex] isItemNotified: user_regularv3rg170203@test-domain.com:message:received:content_29uw5z0206 :: false

2022-10-25 04:34:15 |


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


2022-10-25 04:34:15 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-10-25 04:34:15 | command: <data><node>node_25ts1s0204</node><entry><content>content_p8br3x0207</content></entry></data>

2022-10-25 04:34:15 | target: http://localhost:8088

2022-10-25 04:34:15 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-10-25 04:34:15 | entity: <data><node>node_25ts1s0204</node><entry><content>content_p8br3x0207</content></entry></data>

2022-10-25 04:34:15 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 25 Oct 2022 11:34:15 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-10-25 04:34:15 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>a7f46c65-6506-4366-ad1b-5ed5d4e7e5d6</value></item-id></result>

2022-10-25 04:34:15 | contains: true

2022-10-25 04:34:20 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2022-10-25 04:34:20 | [Mutex] waiting for: [user_regularv3rg170203@test-domain.com:message:received:content_p8br3x0207]

2022-10-25 04:34:20 | [Mutex] received everything.

2022-10-25 04:34:20 | [Mutex] isItemNotified: user_regularv3rg170203@test-domain.com:message:received:content_p8br3x0207 :: true

2022-10-25 04:34:20 |


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


2022-10-25 04:34:20 | [Mutex] received everything.

2022-10-25 04:34:20 | [Mutex] isItemNotified: node_25ts1s0204:subscribe_node:success :: true

2022-10-25 04:34:20 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-10-25 04:34:20 | command: <data><node>node_25ts1s0204</node><expire-at>2022-10-25T11:34:25Z</expire-at><entry><content>content_pldk9n0208</content></entry></data>

2022-10-25 04:34:20 | target: http://localhost:8088

2022-10-25 04:34:20 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-10-25 04:34:20 | entity: <data><node>node_25ts1s0204</node><expire-at>2022-10-25T11:34:25Z</expire-at><entry><content>content_pldk9n0208</content></entry></data>

2022-10-25 04:34:20 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 25 Oct 2022 11:34:20 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-10-25 04:34:20 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>903137ad-5c91-4bcd-8e80-373f72b87321</value></item-id></result>

2022-10-25 04:34:20 | contains: true

2022-10-25 04:34:28 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

2022-10-25 04:34:28 | [Mutex] waiting for: [user_regularv3rg170203@test-domain.com:message:received:content_pldk9n0208]

2022-10-25 04:34:28 | [Mutex] waiting for: [user_regularv3rg170203@test-domain.com:message:received:content_pldk9n0208]

2022-10-25 04:34:28 | [Mutex] waiting for: [user_regularv3rg170203@test-domain.com:message:received:content_pldk9n0208]

2022-10-25 04:34:43 | [Mutex] timeout. Not received [user_regularv3rg170203@test-domain.com:message:received:content_pldk9n0208]

2022-10-25 04:34:43 | [Mutex] received everything.

2022-10-25 04:34:43 | [Mutex] isItemNotified: user_regularv3rg170203@test-domain.com:message:received:content_pldk9n0208 :: false

2022-10-25 04:34:43 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_pldk9n0208 :: true