Test duration : 44.494s
Passed Tests | ||
---|---|---|
tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
testMessageExpiration | 43.600s |
2022-09-27 23:05:17 |
2022-09-27 23:05:17 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2022-09-27 23:05:17 | ------------------------------------ 2022-09-27 23:05:17 | [Mutex] isItemNotified: node_bv7i160204:exists :: false 2022-09-27 23:05:17 | [Mutex] waiting for: [node_bv7i160204:create_node] 2022-09-27 23:05:17 | [Mutex] received everything. 2022-09-27 23:05:17 | [Mutex] isItemNotified: node_bv7i160204:create_node:success :: true 2022-09-27 23:05:17 | [Mutex] waiting for: [node_bv7i160204:subscribe_node] 2022-09-27 23:05:17 | [Mutex] waiting for: [node_bv7i160204:subscribe_node] 2022-09-27 23:05:17 | [Mutex] received everything. 2022-09-27 23:05:17 | [Mutex] isItemNotified: node_bv7i160204:subscribe_node:success :: true 2022-09-27 23:05:17 | ===== publishing normal message (to online) 2022-09-27 23:05:17 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-09-27 23:05:17 | command: <data><node>node_bv7i160204</node><entry><content>content_q88rlf0205</content></entry></data> 2022-09-27 23:05:17 | target: http://localhost:8088 2022-09-27 23:05:17 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-09-27 23:05:17 | entity: <data><node>node_bv7i160204</node><entry><content>content_q88rlf0205</content></entry></data> 2022-09-27 23:05:17 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 28 Sep 2022 06:05:17 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-09-27 23:05:17 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>eed4c32b-ee8e-476f-a307-568521de6561</value></item-id></result> 2022-09-27 23:05:17 | contains: true 2022-09-27 23:05:17 | [Mutex] received everything. 2022-09-27 23:05:17 | [Mutex] isItemNotified: user_regularw0dexo0203@test-domain.com:message:received:content_q88rlf0205 :: true 2022-09-27 23:05:17 | ===== publishing already old message - expecting message being filtered out (to online) 2022-09-27 23:05:17 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-09-27 23:05:17 | command: <data><node>node_bv7i160204</node><expire-at>2022-09-28T06:05:12Z</expire-at><entry><content>content_5xq7pa0206</content></entry></data> 2022-09-27 23:05:17 | target: http://localhost:8088 2022-09-27 23:05:17 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-09-27 23:05:17 | entity: <data><node>node_bv7i160204</node><expire-at>2022-09-28T06:05:12Z</expire-at><entry><content>content_5xq7pa0206</content></entry></data> 2022-09-27 23:05:17 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 28 Sep 2022 06:05:17 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-09-27 23:05:17 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>c07a335e-67b0-4ef4-9155-e532c39269e5</value></item-id></result> 2022-09-27 23:05:17 | contains: true 2022-09-27 23:05:17 | [Mutex] waiting for: [user_regularw0dexo0203@test-domain.com:message:received:content_5xq7pa0206] 2022-09-27 23:05:32 | [Mutex] timeout. Not received [user_regularw0dexo0203@test-domain.com:message:received:content_5xq7pa0206] 2022-09-27 23:05:32 | [Mutex] isItemNotified: user_regularw0dexo0203@test-domain.com:message:received:content_5xq7pa0206 :: false 2022-09-27 23:05:32 | ===== publishing normal message (to offline) 2022-09-27 23:05:32 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-09-27 23:05:32 | command: <data><node>node_bv7i160204</node><entry><content>content_u3692a0207</content></entry></data> 2022-09-27 23:05:32 | target: http://localhost:8088 2022-09-27 23:05:32 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-09-27 23:05:32 | entity: <data><node>node_bv7i160204</node><entry><content>content_u3692a0207</content></entry></data> 2022-09-27 23:05:32 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 28 Sep 2022 06:05:32 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-09-27 23:05:32 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>b04d170c-044a-492b-8ed0-b2c3dfd57761</value></item-id></result> 2022-09-27 23:05:32 | contains: true 2022-09-27 23:05:37 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-09-27 23:05:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] DNS entry stored in session object: localhost:5222 2022-09-27 23:05:37 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-09-27 23:05:37 | [Mutex] waiting for: [user_regularw0dexo0203@test-domain.com:message:received:content_u3692a0207] 2022-09-27 23:05:37 | [Mutex] received everything. 2022-09-27 23:05:37 | [Mutex] isItemNotified: user_regularw0dexo0203@test-domain.com:message:received:content_u3692a0207 :: true 2022-09-27 23:05:37 | ===== publishing already old message - expecting message being filtered out (to offline) 2022-09-27 23:05:37 | [Mutex] received everything. 2022-09-27 23:05:37 | [Mutex] isItemNotified: node_bv7i160204:subscribe_node:success :: true 2022-09-27 23:05:37 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-09-27 23:05:37 | command: <data><node>node_bv7i160204</node><expire-at>2022-09-28T06:05:42Z</expire-at><entry><content>content_pad2c20208</content></entry></data> 2022-09-27 23:05:37 | target: http://localhost:8088 2022-09-27 23:05:37 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-09-27 23:05:37 | entity: <data><node>node_bv7i160204</node><expire-at>2022-09-28T06:05:42Z</expire-at><entry><content>content_pad2c20208</content></entry></data> 2022-09-27 23:05:37 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 28 Sep 2022 06:05:37 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-09-27 23:05:37 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>14fe3791-f08f-4a47-abd2-8da88e4ae63d</value></item-id></result> 2022-09-27 23:05:37 | contains: true 2022-09-27 23:05:45 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-09-27 23:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222 2022-09-27 23:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-09-27 23:05:46 | [Mutex] waiting for: [user_regularw0dexo0203@test-domain.com:message:received:content_pad2c20208] 2022-09-27 23:06:01 | [Mutex] timeout. Not received [user_regularw0dexo0203@test-domain.com:message:received:content_pad2c20208] 2022-09-27 23:06:01 | [Mutex] received everything. 2022-09-27 23:06:01 | [Mutex] isItemNotified: user_regularw0dexo0203@test-domain.com:message:received:content_pad2c20208 :: false 2022-09-27 23:06:01 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_pad2c20208 :: true |