Test duration : 44.964s
Passed Tests | ||
---|---|---|
tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
testMessageExpiration | 43.589s |
2022-07-05 22:33:05 |
2022-07-05 22:33:05 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2022-07-05 22:33:05 | ------------------------------------ 2022-07-05 22:33:05 | [Mutex] isItemNotified: node_i0xi0q0204:exists :: false 2022-07-05 22:33:05 | [Mutex] waiting for: [node_i0xi0q0204:create_node] 2022-07-05 22:33:05 | [Mutex] received everything. 2022-07-05 22:33:05 | [Mutex] isItemNotified: node_i0xi0q0204:create_node:success :: true 2022-07-05 22:33:05 | [Mutex] waiting for: [node_i0xi0q0204:subscribe_node] 2022-07-05 22:33:05 | [Mutex] waiting for: [node_i0xi0q0204:subscribe_node] 2022-07-05 22:33:05 | [Mutex] received everything. 2022-07-05 22:33:05 | [Mutex] isItemNotified: node_i0xi0q0204:subscribe_node:success :: true 2022-07-05 22:33:05 | ===== publishing normal message (to online) 2022-07-05 22:33:05 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-05 22:33:05 | command: <data><node>node_i0xi0q0204</node><entry><content>content_2m0zw0205</content></entry></data> 2022-07-05 22:33:05 | target: http://localhost:8088 2022-07-05 22:33:05 | entity: [Content-Type: application/xml,Content-Length: 92,Chunked: false] 2022-07-05 22:33:05 | entity: <data><node>node_i0xi0q0204</node><entry><content>content_2m0zw0205</content></entry></data> 2022-07-05 22:33:05 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 06 Jul 2022 05:33:05 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-05 22:33:05 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>6fe4ac98-11a0-4c16-9fda-6619e988bbf7</value></item-id></result> 2022-07-05 22:33:05 | contains: true 2022-07-05 22:33:05 | [Mutex] received everything. 2022-07-05 22:33:05 | [Mutex] isItemNotified: user_regularh1vhi30203@test-domain.com:message:received:content_2m0zw0205 :: true 2022-07-05 22:33:05 | ===== publishing already old message - expecting message being filtered out (to online) 2022-07-05 22:33:05 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-05 22:33:05 | command: <data><node>node_i0xi0q0204</node><expire-at>2022-07-06T05:33:00Z</expire-at><entry><content>content_7wiv4w0206</content></entry></data> 2022-07-05 22:33:05 | target: http://localhost:8088 2022-07-05 22:33:05 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-07-05 22:33:05 | entity: <data><node>node_i0xi0q0204</node><expire-at>2022-07-06T05:33:00Z</expire-at><entry><content>content_7wiv4w0206</content></entry></data> 2022-07-05 22:33:05 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 06 Jul 2022 05:33:05 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-05 22:33:05 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>e3fcefa4-6e0e-453e-acc9-22e64d1f7b08</value></item-id></result> 2022-07-05 22:33:05 | contains: true 2022-07-05 22:33:05 | [Mutex] waiting for: [user_regularh1vhi30203@test-domain.com:message:received:content_7wiv4w0206] 2022-07-05 22:33:20 | [Mutex] timeout. Not received [user_regularh1vhi30203@test-domain.com:message:received:content_7wiv4w0206] 2022-07-05 22:33:20 | [Mutex] isItemNotified: user_regularh1vhi30203@test-domain.com:message:received:content_7wiv4w0206 :: false 2022-07-05 22:33:20 | ===== publishing normal message (to offline) 2022-07-05 22:33:20 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-05 22:33:20 | command: <data><node>node_i0xi0q0204</node><entry><content>content_xklse00207</content></entry></data> 2022-07-05 22:33:20 | target: http://localhost:8088 2022-07-05 22:33:20 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-07-05 22:33:20 | entity: <data><node>node_i0xi0q0204</node><entry><content>content_xklse00207</content></entry></data> 2022-07-05 22:33:20 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 06 Jul 2022 05:33:20 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-05 22:33:20 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>cf844bb0-5d79-4c2e-b4ff-0202a034484a</value></item-id></result> 2022-07-05 22:33:20 | contains: true 2022-07-05 22:33:25 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-07-05 22:33:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] DNS entry stored in session object: localhost:5222 2022-07-05 22:33:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-07-05 22:33:25 | [Mutex] waiting for: [user_regularh1vhi30203@test-domain.com:message:received:content_xklse00207] 2022-07-05 22:33:25 | [Mutex] received everything. 2022-07-05 22:33:25 | [Mutex] isItemNotified: user_regularh1vhi30203@test-domain.com:message:received:content_xklse00207 :: true 2022-07-05 22:33:25 | ===== publishing already old message - expecting message being filtered out (to offline) 2022-07-05 22:33:25 | [Mutex] received everything. 2022-07-05 22:33:25 | [Mutex] isItemNotified: node_i0xi0q0204:subscribe_node:success :: true 2022-07-05 22:33:25 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-05 22:33:25 | command: <data><node>node_i0xi0q0204</node><expire-at>2022-07-06T05:33:30Z</expire-at><entry><content>content_d5tupr0208</content></entry></data> 2022-07-05 22:33:25 | target: http://localhost:8088 2022-07-05 22:33:25 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-07-05 22:33:25 | entity: <data><node>node_i0xi0q0204</node><expire-at>2022-07-06T05:33:30Z</expire-at><entry><content>content_d5tupr0208</content></entry></data> 2022-07-05 22:33:25 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 06 Jul 2022 05:33:25 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-05 22:33:25 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>919c1343-ee27-42ec-92a4-54bd92f91d4c</value></item-id></result> 2022-07-05 22:33:25 | contains: true 2022-07-05 22:33:33 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-07-05 22:33:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222 2022-07-05 22:33:33 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-07-05 22:33:33 | [Mutex] waiting for: [user_regularh1vhi30203@test-domain.com:message:received:content_d5tupr0208] 2022-07-05 22:33:33 | [Mutex] waiting for: [user_regularh1vhi30203@test-domain.com:message:received:content_d5tupr0208] 2022-07-05 22:33:48 | [Mutex] timeout. Not received [user_regularh1vhi30203@test-domain.com:message:received:content_d5tupr0208] 2022-07-05 22:33:48 | [Mutex] received everything. 2022-07-05 22:33:48 | [Mutex] isItemNotified: user_regularh1vhi30203@test-domain.com:message:received:content_d5tupr0208 :: false 2022-07-05 22:33:48 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_d5tupr0208 :: true |