Generated by TestNG with ReportNG at 22:50 PDT on Wednesday 24 August 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.574s

Passed Tests
tigase.tests.pubsub.TestRestApiWithMessageExpiration
testMessageExpiration 43.593s
2022-08-24 23:05:00 |

2022-08-24 23:05:00 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration]

2022-08-24 23:05:00 | ------------------------------------

2022-08-24 23:05:00 | [Mutex] isItemNotified: node_lk5c8j0204:exists :: false

2022-08-24 23:05:00 | [Mutex] waiting for: [node_lk5c8j0204:create_node]

2022-08-24 23:05:00 | [Mutex] waiting for: [node_lk5c8j0204:create_node]

2022-08-24 23:05:00 | [Mutex] received everything.

2022-08-24 23:05:00 | [Mutex] isItemNotified: node_lk5c8j0204:create_node:success :: true

2022-08-24 23:05:00 | [Mutex] waiting for: [node_lk5c8j0204:subscribe_node]

2022-08-24 23:05:00 | [Mutex] waiting for: [node_lk5c8j0204:subscribe_node]

2022-08-24 23:05:00 | [Mutex] received everything.

2022-08-24 23:05:00 | [Mutex] isItemNotified: node_lk5c8j0204:subscribe_node:success :: true

2022-08-24 23:05:00 |


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


2022-08-24 23:05:00 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-08-24 23:05:00 | command: <data><node>node_lk5c8j0204</node><entry><content>content_36x1xw0205</content></entry></data>

2022-08-24 23:05:00 | target: http://localhost:8088

2022-08-24 23:05:00 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-08-24 23:05:00 | entity: <data><node>node_lk5c8j0204</node><entry><content>content_36x1xw0205</content></entry></data>

2022-08-24 23:05:00 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 25 Aug 2022 06:05:00 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-08-24 23:05:00 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>6b812bf1-878f-4aac-ab1c-143ea2ba5aa6</value></item-id></result>

2022-08-24 23:05:00 | contains: true

2022-08-24 23:05:00 | [Mutex] received everything.

2022-08-24 23:05:00 | [Mutex] isItemNotified: user_regularl0zt1b0203@test-domain.com:message:received:content_36x1xw0205 :: true

2022-08-24 23:05:00 |


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


2022-08-24 23:05:00 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-08-24 23:05:00 | command: <data><node>node_lk5c8j0204</node><expire-at>2022-08-25T06:04:55Z</expire-at><entry><content>content_xqz3t40206</content></entry></data>

2022-08-24 23:05:00 | target: http://localhost:8088

2022-08-24 23:05:00 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-08-24 23:05:00 | entity: <data><node>node_lk5c8j0204</node><expire-at>2022-08-25T06:04:55Z</expire-at><entry><content>content_xqz3t40206</content></entry></data>

2022-08-24 23:05:00 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 25 Aug 2022 06:05:00 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-08-24 23:05:00 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>3f31d325-5afd-4da9-9286-59bbeaa24be3</value></item-id></result>

2022-08-24 23:05:00 | contains: true

2022-08-24 23:05:00 | [Mutex] waiting for: [user_regularl0zt1b0203@test-domain.com:message:received:content_xqz3t40206]

2022-08-24 23:05:15 | [Mutex] timeout. Not received [user_regularl0zt1b0203@test-domain.com:message:received:content_xqz3t40206]

2022-08-24 23:05:15 | [Mutex] isItemNotified: user_regularl0zt1b0203@test-domain.com:message:received:content_xqz3t40206 :: false

2022-08-24 23:05:15 |


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


2022-08-24 23:05:15 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-08-24 23:05:15 | command: <data><node>node_lk5c8j0204</node><entry><content>content_u2a3tm0207</content></entry></data>

2022-08-24 23:05:15 | target: http://localhost:8088

2022-08-24 23:05:15 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2022-08-24 23:05:15 | entity: <data><node>node_lk5c8j0204</node><entry><content>content_u2a3tm0207</content></entry></data>

2022-08-24 23:05:15 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 25 Aug 2022 06:05:15 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-08-24 23:05:15 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>0079a4e6-b8bf-49a5-8e54-7acb5b2163f6</value></item-id></result>

2022-08-24 23:05:15 | contains: true

2022-08-24 23:05:20 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

2022-08-24 23:05:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-08-24 23:05:20 | [Mutex] waiting for: [user_regularl0zt1b0203@test-domain.com:message:received:content_u2a3tm0207]

2022-08-24 23:05:20 | [Mutex] received everything.

2022-08-24 23:05:20 | [Mutex] isItemNotified: user_regularl0zt1b0203@test-domain.com:message:received:content_u2a3tm0207 :: true

2022-08-24 23:05:20 |


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


2022-08-24 23:05:20 | [Mutex] received everything.

2022-08-24 23:05:20 | [Mutex] isItemNotified: node_lk5c8j0204:subscribe_node:success :: true

2022-08-24 23:05:21 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2022-08-24 23:05:21 | command: <data><node>node_lk5c8j0204</node><expire-at>2022-08-25T06:05:26Z</expire-at><entry><content>content_sk6wut0208</content></entry></data>

2022-08-24 23:05:21 | target: http://localhost:8088

2022-08-24 23:05:21 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2022-08-24 23:05:21 | entity: <data><node>node_lk5c8j0204</node><expire-at>2022-08-25T06:05:26Z</expire-at><entry><content>content_sk6wut0208</content></entry></data>

2022-08-24 23:05:21 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 25 Aug 2022 06:05:21 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2022-08-24 23:05:21 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>818febc0-44b9-44d4-a15e-2702fbf88349</value></item-id></result>

2022-08-24 23:05:21 | contains: true

2022-08-24 23:05:29 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-08-24 23:05:29 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222

2022-08-24 23:05:29 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-08-24 23:05:29 | [Mutex] waiting for: [user_regularl0zt1b0203@test-domain.com:message:received:content_sk6wut0208]

2022-08-24 23:05:29 | [Mutex] waiting for: [user_regularl0zt1b0203@test-domain.com:message:received:content_sk6wut0208]

2022-08-24 23:05:44 | [Mutex] timeout. Not received [user_regularl0zt1b0203@test-domain.com:message:received:content_sk6wut0208]

2022-08-24 23:05:44 | [Mutex] received everything.

2022-08-24 23:05:44 | [Mutex] isItemNotified: user_regularl0zt1b0203@test-domain.com:message:received:content_sk6wut0208 :: false

2022-08-24 23:05:44 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_sk6wut0208 :: true