Test duration : 45.156s
Passed Tests | ||
---|---|---|
tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
testMessageExpiration | 43.793s |
2022-04-14 23:01:58 |
2022-04-14 23:01:58 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2022-04-14 23:01:58 | ------------------------------------ 2022-04-14 23:01:58 | [Mutex] isItemNotified: node_5lzf0s0203:exists :: false 2022-04-14 23:01:58 | [Mutex] waiting for: [node_5lzf0s0203:create_node] 2022-04-14 23:01:58 | [Mutex] received everything. 2022-04-14 23:01:58 | [Mutex] isItemNotified: node_5lzf0s0203:create_node:success :: true 2022-04-14 23:01:58 | [Mutex] waiting for: [node_5lzf0s0203:subscribe_node] 2022-04-14 23:01:58 | [Mutex] waiting for: [node_5lzf0s0203:subscribe_node] 2022-04-14 23:01:58 | [Mutex] received everything. 2022-04-14 23:01:58 | [Mutex] isItemNotified: node_5lzf0s0203:subscribe_node:success :: true 2022-04-14 23:01:58 | ===== publishing normal message (to online) 2022-04-14 23:01:58 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-04-14 23:01:58 | command: <data><node>node_5lzf0s0203</node><entry><content>content_slpe7c0204</content></entry></data> 2022-04-14 23:01:58 | target: http://localhost:8088 2022-04-14 23:01:58 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-04-14 23:01:58 | entity: <data><node>node_5lzf0s0203</node><entry><content>content_slpe7c0204</content></entry></data> 2022-04-14 23:01:58 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Fri, 15 Apr 2022 06:01:58 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-04-14 23:01:58 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>2cac2578-cab4-4c6f-89c3-2f60652cb5c8</value></item-id></result> 2022-04-14 23:01:58 | contains: true 2022-04-14 23:01:58 | [Mutex] received everything. 2022-04-14 23:01:58 | [Mutex] isItemNotified: user_regular4ytckk0202@test-domain.com:message:received:content_slpe7c0204 :: true 2022-04-14 23:01:58 | ===== publishing already old message - expecting message being filtered out (to online) 2022-04-14 23:01:58 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-04-14 23:01:58 | command: <data><node>node_5lzf0s0203</node><expire-at>2022-04-15T06:01:53Z</expire-at><entry><content>content_y60qct0205</content></entry></data> 2022-04-14 23:01:58 | target: http://localhost:8088 2022-04-14 23:01:58 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-04-14 23:01:58 | entity: <data><node>node_5lzf0s0203</node><expire-at>2022-04-15T06:01:53Z</expire-at><entry><content>content_y60qct0205</content></entry></data> 2022-04-14 23:01:58 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Fri, 15 Apr 2022 06:01:58 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-04-14 23:01:58 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>ca1c0b37-3fa2-4d84-b4f0-f5e7c989f0b1</value></item-id></result> 2022-04-14 23:01:58 | contains: true 2022-04-14 23:01:58 | [Mutex] waiting for: [user_regular4ytckk0202@test-domain.com:message:received:content_y60qct0205] 2022-04-14 23:02:13 | [Mutex] timeout. Not received [user_regular4ytckk0202@test-domain.com:message:received:content_y60qct0205] 2022-04-14 23:02:13 | [Mutex] isItemNotified: user_regular4ytckk0202@test-domain.com:message:received:content_y60qct0205 :: false 2022-04-14 23:02:13 | ===== publishing normal message (to offline) 2022-04-14 23:02:13 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-04-14 23:02:13 | command: <data><node>node_5lzf0s0203</node><entry><content>content_ajp0au0206</content></entry></data> 2022-04-14 23:02:13 | target: http://localhost:8088 2022-04-14 23:02:13 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-04-14 23:02:13 | entity: <data><node>node_5lzf0s0203</node><entry><content>content_ajp0au0206</content></entry></data> 2022-04-14 23:02:13 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Fri, 15 Apr 2022 06:02:13 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-04-14 23:02:13 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>2a5b36fb-7cd0-4577-8221-6a558dc4914c</value></item-id></result> 2022-04-14 23:02:13 | contains: true 2022-04-14 23:02:18 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-04-14 23:02:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=476 thread=1] DNS entry stored in session object: localhost:5222 2022-04-14 23:02:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=476 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-04-14 23:02:19 | [Mutex] waiting for: [user_regular4ytckk0202@test-domain.com:message:received:content_ajp0au0206] 2022-04-14 23:02:19 | [Mutex] received everything. 2022-04-14 23:02:19 | [Mutex] isItemNotified: user_regular4ytckk0202@test-domain.com:message:received:content_ajp0au0206 :: true 2022-04-14 23:02:19 | ===== publishing already old message - expecting message being filtered out (to offline) 2022-04-14 23:02:19 | [Mutex] received everything. 2022-04-14 23:02:19 | [Mutex] isItemNotified: node_5lzf0s0203:subscribe_node:success :: true 2022-04-14 23:02:19 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-04-14 23:02:19 | command: <data><node>node_5lzf0s0203</node><expire-at>2022-04-15T06:02:24Z</expire-at><entry><content>content_do49j0207</content></entry></data> 2022-04-14 23:02:19 | target: http://localhost:8088 2022-04-14 23:02:19 | entity: [Content-Type: application/xml,Content-Length: 135,Chunked: false] 2022-04-14 23:02:19 | entity: <data><node>node_5lzf0s0203</node><expire-at>2022-04-15T06:02:24Z</expire-at><entry><content>content_do49j0207</content></entry></data> 2022-04-14 23:02:19 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Fri, 15 Apr 2022 06:02:19 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-04-14 23:02:19 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>d8eafeda-da2b-452e-93b5-96429fd8408a</value></item-id></result> 2022-04-14 23:02:19 | contains: true 2022-04-14 23:02:27 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-04-14 23:02:27 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=477 thread=1] DNS entry stored in session object: localhost:5222 2022-04-14 23:02:27 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=477 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-04-14 23:02:27 | [Mutex] waiting for: [user_regular4ytckk0202@test-domain.com:message:received:content_do49j0207] 2022-04-14 23:02:27 | [Mutex] waiting for: [user_regular4ytckk0202@test-domain.com:message:received:content_do49j0207] 2022-04-14 23:02:42 | [Mutex] timeout. Not received [user_regular4ytckk0202@test-domain.com:message:received:content_do49j0207] 2022-04-14 23:02:42 | [Mutex] received everything. 2022-04-14 23:02:42 | [Mutex] isItemNotified: user_regular4ytckk0202@test-domain.com:message:received:content_do49j0207 :: false 2022-04-14 23:02:42 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_do49j0207 :: true |