Test duration : 44.891s
Passed Tests | ||
---|---|---|
tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
testMessageExpiration | 43.573s |
2022-07-20 22:32:34 |
2022-07-20 22:32:34 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2022-07-20 22:32:34 | ------------------------------------ 2022-07-20 22:32:34 | [Mutex] isItemNotified: node_p5ypd70204:exists :: false 2022-07-20 22:32:34 | [Mutex] waiting for: [node_p5ypd70204:create_node] 2022-07-20 22:32:34 | [Mutex] received everything. 2022-07-20 22:32:34 | [Mutex] isItemNotified: node_p5ypd70204:create_node:success :: true 2022-07-20 22:32:34 | [Mutex] waiting for: [node_p5ypd70204:subscribe_node] 2022-07-20 22:32:34 | [Mutex] waiting for: [node_p5ypd70204:subscribe_node] 2022-07-20 22:32:34 | [Mutex] received everything. 2022-07-20 22:32:34 | [Mutex] isItemNotified: node_p5ypd70204:subscribe_node:success :: true 2022-07-20 22:32:34 | ===== publishing normal message (to online) 2022-07-20 22:32:34 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-20 22:32:34 | command: <data><node>node_p5ypd70204</node><entry><content>content_uyxxo50205</content></entry></data> 2022-07-20 22:32:34 | target: http://localhost:8088 2022-07-20 22:32:34 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-07-20 22:32:34 | entity: <data><node>node_p5ypd70204</node><entry><content>content_uyxxo50205</content></entry></data> 2022-07-20 22:32:34 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 21 Jul 2022 05:32:34 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-20 22:32:34 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>4f43d491-d523-4386-96f7-2178ab23044d</value></item-id></result> 2022-07-20 22:32:34 | contains: true 2022-07-20 22:32:34 | [Mutex] received everything. 2022-07-20 22:32:34 | [Mutex] isItemNotified: user_regular5tyfk40203@test-domain.com:message:received:content_uyxxo50205 :: true 2022-07-20 22:32:34 | ===== publishing already old message - expecting message being filtered out (to online) 2022-07-20 22:32:34 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-20 22:32:34 | command: <data><node>node_p5ypd70204</node><expire-at>2022-07-21T05:32:29Z</expire-at><entry><content>content_3uv7p90206</content></entry></data> 2022-07-20 22:32:34 | target: http://localhost:8088 2022-07-20 22:32:34 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-07-20 22:32:34 | entity: <data><node>node_p5ypd70204</node><expire-at>2022-07-21T05:32:29Z</expire-at><entry><content>content_3uv7p90206</content></entry></data> 2022-07-20 22:32:34 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 21 Jul 2022 05:32:34 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-20 22:32:34 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>8df16c63-949e-4117-aa45-dcd28a344fa5</value></item-id></result> 2022-07-20 22:32:34 | contains: true 2022-07-20 22:32:34 | [Mutex] waiting for: [user_regular5tyfk40203@test-domain.com:message:received:content_3uv7p90206] 2022-07-20 22:32:49 | [Mutex] timeout. Not received [user_regular5tyfk40203@test-domain.com:message:received:content_3uv7p90206] 2022-07-20 22:32:49 | [Mutex] isItemNotified: user_regular5tyfk40203@test-domain.com:message:received:content_3uv7p90206 :: false 2022-07-20 22:32:49 | ===== publishing normal message (to offline) 2022-07-20 22:32:50 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-20 22:32:50 | command: <data><node>node_p5ypd70204</node><entry><content>content_a6ejy30207</content></entry></data> 2022-07-20 22:32:50 | target: http://localhost:8088 2022-07-20 22:32:50 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-07-20 22:32:50 | entity: <data><node>node_p5ypd70204</node><entry><content>content_a6ejy30207</content></entry></data> 2022-07-20 22:32:50 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 21 Jul 2022 05:32:50 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-20 22:32:50 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>48f36f43-5e4b-4161-8767-f7a9ca79a1a9</value></item-id></result> 2022-07-20 22:32:50 | contains: true 2022-07-20 22:32:55 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-07-20 22:32:55 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] DNS entry stored in session object: localhost:5222 2022-07-20 22:32:55 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-07-20 22:32:55 | [Mutex] waiting for: [user_regular5tyfk40203@test-domain.com:message:received:content_a6ejy30207] 2022-07-20 22:32:55 | [Mutex] received everything. 2022-07-20 22:32:55 | [Mutex] isItemNotified: user_regular5tyfk40203@test-domain.com:message:received:content_a6ejy30207 :: true 2022-07-20 22:32:55 | ===== publishing already old message - expecting message being filtered out (to offline) 2022-07-20 22:32:55 | [Mutex] received everything. 2022-07-20 22:32:55 | [Mutex] isItemNotified: node_p5ypd70204:subscribe_node:success :: true 2022-07-20 22:32:55 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-07-20 22:32:55 | command: <data><node>node_p5ypd70204</node><expire-at>2022-07-21T05:33:00Z</expire-at><entry><content>content_yuvc1y0208</content></entry></data> 2022-07-20 22:32:55 | target: http://localhost:8088 2022-07-20 22:32:55 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-07-20 22:32:55 | entity: <data><node>node_p5ypd70204</node><expire-at>2022-07-21T05:33:00Z</expire-at><entry><content>content_yuvc1y0208</content></entry></data> 2022-07-20 22:32:55 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 21 Jul 2022 05:32:55 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-07-20 22:32:55 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>1db45293-754a-417e-bfa6-38a57eb27b2e</value></item-id></result> 2022-07-20 22:32:55 | contains: true 2022-07-20 22:33:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-07-20 22:33:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222 2022-07-20 22:33:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-07-20 22:33:03 | [Mutex] waiting for: [user_regular5tyfk40203@test-domain.com:message:received:content_yuvc1y0208] 2022-07-20 22:33:18 | [Mutex] timeout. Not received [user_regular5tyfk40203@test-domain.com:message:received:content_yuvc1y0208] 2022-07-20 22:33:18 | [Mutex] received everything. 2022-07-20 22:33:18 | [Mutex] isItemNotified: user_regular5tyfk40203@test-domain.com:message:received:content_yuvc1y0208 :: false 2022-07-20 22:33:18 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_yuvc1y0208 :: true |