Generated by TestNG with ReportNG at 22:53 PDT on Monday 31 July 2023
root@f44fc83e2390 / Java 17.0.7 (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.650s

Passed Tests
tigase.tests.pubsub.TestRestApiWithMessageExpiration
testMessageExpiration 43.548s
2023-07-31 23:07:28 |

2023-07-31 23:07:28 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration]

2023-07-31 23:07:28 | ------------------------------------

2023-07-31 23:07:28 | [Mutex] isItemNotified: node_qurbz60208:exists :: false

2023-07-31 23:07:28 | [Mutex] waiting for: [node_qurbz60208:create_node]

2023-07-31 23:07:28 | [Mutex] received everything.

2023-07-31 23:07:28 | [Mutex] isItemNotified: node_qurbz60208:create_node:success :: true

2023-07-31 23:07:28 | [Mutex] waiting for: [node_qurbz60208:subscribe_node]

2023-07-31 23:07:28 | [Mutex] waiting for: [node_qurbz60208:subscribe_node]

2023-07-31 23:07:28 | [Mutex] received everything.

2023-07-31 23:07:28 | [Mutex] isItemNotified: node_qurbz60208:subscribe_node:success :: true

2023-07-31 23:07:28 |


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


2023-07-31 23:07:28 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2023-07-31 23:07:28 | command: <data><node>node_qurbz60208</node><entry><content>content_o4bg6k0209</content></entry></data>

2023-07-31 23:07:28 | target: http://localhost:8088

2023-07-31 23:07:28 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false]

2023-07-31 23:07:28 | entity: <data><node>node_qurbz60208</node><entry><content>content_o4bg6k0209</content></entry></data>

2023-07-31 23:07:28 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 01 Aug 2023 06:07:28 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2023-07-31 23:07:28 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>f6e9b1fb-d4ef-4b41-89a0-3cd3b0f4092d</value></item-id></result>

2023-07-31 23:07:28 | contains: true

2023-07-31 23:07:28 | [Mutex] waiting for: [user_regularvyvki50207@test-domain.com:message:received:content_o4bg6k0209]

2023-07-31 23:07:28 | [Mutex] received everything.

2023-07-31 23:07:28 | [Mutex] isItemNotified: user_regularvyvki50207@test-domain.com:message:received:content_o4bg6k0209 :: true

2023-07-31 23:07:28 |


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


2023-07-31 23:07:28 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2023-07-31 23:07:28 | command: <data><node>node_qurbz60208</node><expire-at>2023-08-01T06:07:23Z</expire-at><entry><content>content_jnpbth0210</content></entry></data>

2023-07-31 23:07:28 | target: http://localhost:8088

2023-07-31 23:07:28 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2023-07-31 23:07:28 | entity: <data><node>node_qurbz60208</node><expire-at>2023-08-01T06:07:23Z</expire-at><entry><content>content_jnpbth0210</content></entry></data>

2023-07-31 23:07:28 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 01 Aug 2023 06:07:28 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2023-07-31 23:07:28 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>dfa5643c-b759-4df5-8ba2-575008d4dacb</value></item-id></result>

2023-07-31 23:07:28 | contains: true

2023-07-31 23:07:28 | [Mutex] waiting for: [user_regularvyvki50207@test-domain.com:message:received:content_jnpbth0210]

2023-07-31 23:07:43 | [Mutex] timeout. Not received [user_regularvyvki50207@test-domain.com:message:received:content_jnpbth0210]

2023-07-31 23:07:43 | [Mutex] isItemNotified: user_regularvyvki50207@test-domain.com:message:received:content_jnpbth0210 :: false

2023-07-31 23:07:43 |


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


2023-07-31 23:07:43 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2023-07-31 23:07:43 | command: <data><node>node_qurbz60208</node><entry><content>content_qjo5m0211</content></entry></data>

2023-07-31 23:07:43 | target: http://localhost:8088

2023-07-31 23:07:43 | entity: [Content-Type: application/xml,Content-Length: 92,Chunked: false]

2023-07-31 23:07:43 | entity: <data><node>node_qurbz60208</node><entry><content>content_qjo5m0211</content></entry></data>

2023-07-31 23:07:44 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 01 Aug 2023 06:07:44 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2023-07-31 23:07:44 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>76ecaafb-308d-4ab1-b5dc-59312beb5fc0</value></item-id></result>

2023-07-31 23:07:44 | contains: true

2023-07-31 23:07:49 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2023-07-31 23:07:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=485 thread=1] DNS entry stored in session object: localhost:5222

2023-07-31 23:07:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=485 thread=1] Opening connection to localhost/127.0.0.1:5222

2023-07-31 23:07:49 | [Mutex] waiting for: [user_regularvyvki50207@test-domain.com:message:received:content_qjo5m0211]

2023-07-31 23:07:49 | [Mutex] waiting for: [user_regularvyvki50207@test-domain.com:message:received:content_qjo5m0211]

2023-07-31 23:07:49 | [Mutex] received everything.

2023-07-31 23:07:49 | [Mutex] isItemNotified: user_regularvyvki50207@test-domain.com:message:received:content_qjo5m0211 :: true

2023-07-31 23:07:49 |


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


2023-07-31 23:07:49 | [Mutex] received everything.

2023-07-31 23:07:49 | [Mutex] isItemNotified: node_qurbz60208:subscribe_node:success :: true

2023-07-31 23:07:49 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1

2023-07-31 23:07:49 | command: <data><node>node_qurbz60208</node><expire-at>2023-08-01T06:07:54Z</expire-at><entry><content>content_53dohm0212</content></entry></data>

2023-07-31 23:07:49 | target: http://localhost:8088

2023-07-31 23:07:49 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false]

2023-07-31 23:07:49 | entity: <data><node>node_qurbz60208</node><expire-at>2023-08-01T06:07:54Z</expire-at><entry><content>content_53dohm0212</content></entry></data>

2023-07-31 23:07:49 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 01 Aug 2023 06:07:49 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}}

2023-07-31 23:07:49 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>9ccaba8c-c6d1-4fbb-8f88-3b7e26ef7404</value></item-id></result>

2023-07-31 23:07:49 | contains: true

2023-07-31 23:07:57 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2023-07-31 23:07:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=486 thread=1] DNS entry stored in session object: localhost:5222

2023-07-31 23:07:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=486 thread=1] Opening connection to localhost/127.0.0.1:5222

2023-07-31 23:07:57 | [Mutex] waiting for: [user_regularvyvki50207@test-domain.com:message:received:content_53dohm0212]

2023-07-31 23:08:12 | [Mutex] timeout. Not received [user_regularvyvki50207@test-domain.com:message:received:content_53dohm0212]

2023-07-31 23:08:12 | [Mutex] received everything.

2023-07-31 23:08:12 | [Mutex] isItemNotified: user_regularvyvki50207@test-domain.com:message:received:content_53dohm0212 :: false

2023-07-31 23:08:12 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_53dohm0212 :: true