Test duration : 44.522s
Passed Tests | ||
---|---|---|
tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
testMessageExpiration | 43.613s |
2022-07-09 23:04:57 |
2022-07-09 23:04:57 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2022-07-09 23:04:57 | ------------------------------------ 2022-07-09 23:04:57 | [Mutex] isItemNotified: node_l7g9n00204:exists :: false 2022-07-09 23:04:57 | [Mutex] waiting for: [node_l7g9n00204:create_node] 2022-07-09 23:04:57 | [Mutex] received everything. 2022-07-09 23:04:57 | [Mutex] isItemNotified: node_l7g9n00204:create_node:success :: true 2022-07-09 23:04:57 | [Mutex] waiting for: [node_l7g9n00204:subscribe_node] 2022-07-09 23:04:57 | [Mutex] waiting for: [node_l7g9n00204:subscribe_node] 2022-07-09 23:04:57 | [Mutex] received everything. 2022-07-09 23:04:57 | [Mutex] isItemNotified: node_l7g9n00204:subscribe_node:success :: true 2022-07-09 23:04:57 | ===== publishing normal message (to online) 2022-07-09 23:04:57 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-09 23:04:57 | command: <data><node>node_l7g9n00204</node><entry><content>content_2stz9v0205</content></entry></data> 2022-07-09 23:04:57 | target: http://localhost:8088 2022-07-09 23:04:57 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-07-09 23:04:57 | entity: <data><node>node_l7g9n00204</node><entry><content>content_2stz9v0205</content></entry></data> 2022-07-09 23:04:57 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sun, 10 Jul 2022 06:04:57 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-09 23:04:57 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>ffa3ecaa-9f90-47f6-a9eb-e986870b833a</value></item-id></result> 2022-07-09 23:04:57 | contains: true 2022-07-09 23:04:57 | [Mutex] received everything. 2022-07-09 23:04:57 | [Mutex] isItemNotified: user_regularetuwcm0203@test-domain.com:message:received:content_2stz9v0205 :: true 2022-07-09 23:04:57 | ===== publishing already old message - expecting message being filtered out (to online) 2022-07-09 23:04:57 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-09 23:04:57 | command: <data><node>node_l7g9n00204</node><expire-at>2022-07-10T06:04:52Z</expire-at><entry><content>content_wj2k910206</content></entry></data> 2022-07-09 23:04:57 | target: http://localhost:8088 2022-07-09 23:04:57 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-07-09 23:04:57 | entity: <data><node>node_l7g9n00204</node><expire-at>2022-07-10T06:04:52Z</expire-at><entry><content>content_wj2k910206</content></entry></data> 2022-07-09 23:04:57 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sun, 10 Jul 2022 06:04:57 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-09 23:04:57 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>2567420d-51ea-4199-aff4-a0a1dd476fbe</value></item-id></result> 2022-07-09 23:04:57 | contains: true 2022-07-09 23:04:57 | [Mutex] waiting for: [user_regularetuwcm0203@test-domain.com:message:received:content_wj2k910206] 2022-07-09 23:05:12 | [Mutex] timeout. Not received [user_regularetuwcm0203@test-domain.com:message:received:content_wj2k910206] 2022-07-09 23:05:12 | [Mutex] isItemNotified: user_regularetuwcm0203@test-domain.com:message:received:content_wj2k910206 :: false 2022-07-09 23:05:12 | ===== publishing normal message (to offline) 2022-07-09 23:05:12 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-09 23:05:12 | command: <data><node>node_l7g9n00204</node><entry><content>content_s88wp40207</content></entry></data> 2022-07-09 23:05:12 | target: http://localhost:8088 2022-07-09 23:05:12 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-07-09 23:05:12 | entity: <data><node>node_l7g9n00204</node><entry><content>content_s88wp40207</content></entry></data> 2022-07-09 23:05:12 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sun, 10 Jul 2022 06:05:12 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-09 23:05:12 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>cb74e0a4-ecf7-47a7-ae2a-63b2a55cf96d</value></item-id></result> 2022-07-09 23:05:12 | contains: true 2022-07-09 23:05:17 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-07-09 23:05:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] DNS entry stored in session object: localhost:5222 2022-07-09 23:05:17 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-07-09 23:05:17 | [Mutex] waiting for: [user_regularetuwcm0203@test-domain.com:message:received:content_s88wp40207] 2022-07-09 23:05:17 | [Mutex] received everything. 2022-07-09 23:05:17 | [Mutex] isItemNotified: user_regularetuwcm0203@test-domain.com:message:received:content_s88wp40207 :: true 2022-07-09 23:05:17 | ===== publishing already old message - expecting message being filtered out (to offline) 2022-07-09 23:05:17 | [Mutex] received everything. 2022-07-09 23:05:17 | [Mutex] isItemNotified: node_l7g9n00204:subscribe_node:success :: true 2022-07-09 23:05:17 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-09 23:05:17 | command: <data><node>node_l7g9n00204</node><expire-at>2022-07-10T06:05:22Z</expire-at><entry><content>content_v27crj0208</content></entry></data> 2022-07-09 23:05:17 | target: http://localhost:8088 2022-07-09 23:05:17 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-07-09 23:05:17 | entity: <data><node>node_l7g9n00204</node><expire-at>2022-07-10T06:05:22Z</expire-at><entry><content>content_v27crj0208</content></entry></data> 2022-07-09 23:05:17 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Sun, 10 Jul 2022 06:05:17 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-09 23:05:17 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>f9926507-5beb-48f9-b00b-f4d11e0e763e</value></item-id></result> 2022-07-09 23:05:17 | contains: true 2022-07-09 23:05:25 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-07-09 23:05:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222 2022-07-09 23:05:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-07-09 23:05:26 | [Mutex] waiting for: [user_regularetuwcm0203@test-domain.com:message:received:content_v27crj0208] 2022-07-09 23:05:41 | [Mutex] timeout. Not received [user_regularetuwcm0203@test-domain.com:message:received:content_v27crj0208] 2022-07-09 23:05:41 | [Mutex] received everything. 2022-07-09 23:05:41 | [Mutex] isItemNotified: user_regularetuwcm0203@test-domain.com:message:received:content_v27crj0208 :: false 2022-07-09 23:05:41 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_v27crj0208 :: true |