Test duration : 44.893s
Passed Tests | ||
---|---|---|
tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
testMessageExpiration | 43.641s |
2022-09-06 22:34:03 |
2022-09-06 22:34:03 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2022-09-06 22:34:03 | ------------------------------------ 2022-09-06 22:34:03 | [Mutex] isItemNotified: node_ps45xz0204:exists :: false 2022-09-06 22:34:03 | [Mutex] waiting for: [node_ps45xz0204:create_node] 2022-09-06 22:34:03 | [Mutex] received everything. 2022-09-06 22:34:03 | [Mutex] isItemNotified: node_ps45xz0204:create_node:success :: true 2022-09-06 22:34:03 | [Mutex] waiting for: [node_ps45xz0204:subscribe_node] 2022-09-06 22:34:03 | [Mutex] waiting for: [node_ps45xz0204:subscribe_node] 2022-09-06 22:34:03 | [Mutex] received everything. 2022-09-06 22:34:03 | [Mutex] isItemNotified: node_ps45xz0204:subscribe_node:success :: true 2022-09-06 22:34:03 | ===== publishing normal message (to online) 2022-09-06 22:34:03 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-09-06 22:34:03 | command: <data><node>node_ps45xz0204</node><entry><content>content_vohhqo0205</content></entry></data> 2022-09-06 22:34:03 | target: http://localhost:8088 2022-09-06 22:34:03 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-09-06 22:34:03 | entity: <data><node>node_ps45xz0204</node><entry><content>content_vohhqo0205</content></entry></data> 2022-09-06 22:34:03 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 07 Sep 2022 05:34:03 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-09-06 22:34:03 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>519b50a7-cfa4-4319-98e7-986e3ebbd7a5</value></item-id></result> 2022-09-06 22:34:03 | contains: true 2022-09-06 22:34:03 | [Mutex] received everything. 2022-09-06 22:34:03 | [Mutex] isItemNotified: user_regular1lsx5p0203@test-domain.com:message:received:content_vohhqo0205 :: true 2022-09-06 22:34:03 | ===== publishing already old message - expecting message being filtered out (to online) 2022-09-06 22:34:03 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-09-06 22:34:03 | command: <data><node>node_ps45xz0204</node><expire-at>2022-09-07T05:33:58Z</expire-at><entry><content>content_t1a6k70206</content></entry></data> 2022-09-06 22:34:03 | target: http://localhost:8088 2022-09-06 22:34:03 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-09-06 22:34:03 | entity: <data><node>node_ps45xz0204</node><expire-at>2022-09-07T05:33:58Z</expire-at><entry><content>content_t1a6k70206</content></entry></data> 2022-09-06 22:34:03 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 07 Sep 2022 05:34:03 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-09-06 22:34:03 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>5c430d6f-896f-4abb-8f4e-f56e6bde6eac</value></item-id></result> 2022-09-06 22:34:03 | contains: true 2022-09-06 22:34:03 | [Mutex] waiting for: [user_regular1lsx5p0203@test-domain.com:message:received:content_t1a6k70206] 2022-09-06 22:34:18 | [Mutex] timeout. Not received [user_regular1lsx5p0203@test-domain.com:message:received:content_t1a6k70206] 2022-09-06 22:34:18 | [Mutex] isItemNotified: user_regular1lsx5p0203@test-domain.com:message:received:content_t1a6k70206 :: false 2022-09-06 22:34:18 | ===== publishing normal message (to offline) 2022-09-06 22:34:18 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-09-06 22:34:18 | command: <data><node>node_ps45xz0204</node><entry><content>content_brxk740207</content></entry></data> 2022-09-06 22:34:18 | target: http://localhost:8088 2022-09-06 22:34:18 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-09-06 22:34:18 | entity: <data><node>node_ps45xz0204</node><entry><content>content_brxk740207</content></entry></data> 2022-09-06 22:34:18 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 07 Sep 2022 05:34:18 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-09-06 22:34:18 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>55048768-4d53-40ff-8491-cd9291e1d4f6</value></item-id></result> 2022-09-06 22:34:18 | contains: true 2022-09-06 22:34:23 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-09-06 22:34:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] DNS entry stored in session object: localhost:5222 2022-09-06 22:34:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-09-06 22:34:23 | [Mutex] waiting for: [user_regular1lsx5p0203@test-domain.com:message:received:content_brxk740207] 2022-09-06 22:34:23 | [Mutex] received everything. 2022-09-06 22:34:23 | [Mutex] isItemNotified: user_regular1lsx5p0203@test-domain.com:message:received:content_brxk740207 :: true 2022-09-06 22:34:23 | ===== publishing already old message - expecting message being filtered out (to offline) 2022-09-06 22:34:23 | [Mutex] received everything. 2022-09-06 22:34:23 | [Mutex] isItemNotified: node_ps45xz0204:subscribe_node:success :: true 2022-09-06 22:34:23 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-09-06 22:34:23 | command: <data><node>node_ps45xz0204</node><expire-at>2022-09-07T05:34:28Z</expire-at><entry><content>content_4kdtw90208</content></entry></data> 2022-09-06 22:34:23 | target: http://localhost:8088 2022-09-06 22:34:23 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-09-06 22:34:23 | entity: <data><node>node_ps45xz0204</node><expire-at>2022-09-07T05:34:28Z</expire-at><entry><content>content_4kdtw90208</content></entry></data> 2022-09-06 22:34:23 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 07 Sep 2022 05:34:23 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-09-06 22:34:23 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>ead6729b-9afc-4d89-a841-c1c7be5c1651</value></item-id></result> 2022-09-06 22:34:23 | contains: true 2022-09-06 22:34:31 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-09-06 22:34:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222 2022-09-06 22:34:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-09-06 22:34:31 | [Mutex] waiting for: [user_regular1lsx5p0203@test-domain.com:message:received:content_4kdtw90208] 2022-09-06 22:34:31 | [Mutex] waiting for: [user_regular1lsx5p0203@test-domain.com:message:received:content_4kdtw90208] 2022-09-06 22:34:31 | [Mutex] waiting for: [user_regular1lsx5p0203@test-domain.com:message:received:content_4kdtw90208] 2022-09-06 22:34:46 | [Mutex] timeout. Not received [user_regular1lsx5p0203@test-domain.com:message:received:content_4kdtw90208] 2022-09-06 22:34:46 | [Mutex] received everything. 2022-09-06 22:34:46 | [Mutex] isItemNotified: user_regular1lsx5p0203@test-domain.com:message:received:content_4kdtw90208 :: false 2022-09-06 22:34:46 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_4kdtw90208 :: true |