Test duration : 44.840s
Passed Tests | ||
---|---|---|
tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
testMessageExpiration | 43.612s |
2022-08-22 22:34:26 |
2022-08-22 22:34:26 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2022-08-22 22:34:26 | ------------------------------------ 2022-08-22 22:34:26 | [Mutex] isItemNotified: node_8d602i0204:exists :: false 2022-08-22 22:34:26 | [Mutex] waiting for: [node_8d602i0204:create_node] 2022-08-22 22:34:26 | [Mutex] received everything. 2022-08-22 22:34:26 | [Mutex] isItemNotified: node_8d602i0204:create_node:success :: true 2022-08-22 22:34:26 | [Mutex] waiting for: [node_8d602i0204:subscribe_node] 2022-08-22 22:34:26 | [Mutex] waiting for: [node_8d602i0204:subscribe_node] 2022-08-22 22:34:26 | [Mutex] received everything. 2022-08-22 22:34:26 | [Mutex] isItemNotified: node_8d602i0204:subscribe_node:success :: true 2022-08-22 22:34:26 | ===== publishing normal message (to online) 2022-08-22 22:34:26 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-08-22 22:34:26 | command: <data><node>node_8d602i0204</node><entry><content>content_3idj2x0205</content></entry></data> 2022-08-22 22:34:26 | target: http://localhost:8088 2022-08-22 22:34:26 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-08-22 22:34:26 | entity: <data><node>node_8d602i0204</node><entry><content>content_3idj2x0205</content></entry></data> 2022-08-22 22:34:26 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 23 Aug 2022 05:34:26 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-08-22 22:34:26 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>7ae2d9bf-7b38-466d-bbf0-acf9d08550dd</value></item-id></result> 2022-08-22 22:34:26 | contains: true 2022-08-22 22:34:26 | [Mutex] received everything. 2022-08-22 22:34:26 | [Mutex] isItemNotified: user_regularazf3rf0203@test-domain.com:message:received:content_3idj2x0205 :: true 2022-08-22 22:34:26 | ===== publishing already old message - expecting message being filtered out (to online) 2022-08-22 22:34:26 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-08-22 22:34:26 | command: <data><node>node_8d602i0204</node><expire-at>2022-08-23T05:34:21Z</expire-at><entry><content>content_l5s5qj0206</content></entry></data> 2022-08-22 22:34:26 | target: http://localhost:8088 2022-08-22 22:34:26 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-08-22 22:34:26 | entity: <data><node>node_8d602i0204</node><expire-at>2022-08-23T05:34:21Z</expire-at><entry><content>content_l5s5qj0206</content></entry></data> 2022-08-22 22:34:26 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 23 Aug 2022 05:34:26 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-08-22 22:34:26 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>5e347d31-070a-4959-a308-fdf772238caa</value></item-id></result> 2022-08-22 22:34:26 | contains: true 2022-08-22 22:34:26 | [Mutex] waiting for: [user_regularazf3rf0203@test-domain.com:message:received:content_l5s5qj0206] 2022-08-22 22:34:41 | [Mutex] timeout. Not received [user_regularazf3rf0203@test-domain.com:message:received:content_l5s5qj0206] 2022-08-22 22:34:41 | [Mutex] isItemNotified: user_regularazf3rf0203@test-domain.com:message:received:content_l5s5qj0206 :: false 2022-08-22 22:34:41 | ===== publishing normal message (to offline) 2022-08-22 22:34:41 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-08-22 22:34:41 | command: <data><node>node_8d602i0204</node><entry><content>content_ysqfq80207</content></entry></data> 2022-08-22 22:34:41 | target: http://localhost:8088 2022-08-22 22:34:41 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-08-22 22:34:41 | entity: <data><node>node_8d602i0204</node><entry><content>content_ysqfq80207</content></entry></data> 2022-08-22 22:34:41 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 23 Aug 2022 05:34:41 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-08-22 22:34:41 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>74767ce7-b7b0-43c3-a603-59d6625381fa</value></item-id></result> 2022-08-22 22:34:41 | contains: true 2022-08-22 22:34:46 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-22 22:34:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] DNS entry stored in session object: localhost:5222 2022-08-22 22:34:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-08-22 22:34:46 | [Mutex] waiting for: [user_regularazf3rf0203@test-domain.com:message:received:content_ysqfq80207] 2022-08-22 22:34:46 | [Mutex] received everything. 2022-08-22 22:34:46 | [Mutex] isItemNotified: user_regularazf3rf0203@test-domain.com:message:received:content_ysqfq80207 :: true 2022-08-22 22:34:46 | ===== publishing already old message - expecting message being filtered out (to offline) 2022-08-22 22:34:46 | [Mutex] received everything. 2022-08-22 22:34:46 | [Mutex] isItemNotified: node_8d602i0204:subscribe_node:success :: true 2022-08-22 22:34:46 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-08-22 22:34:46 | command: <data><node>node_8d602i0204</node><expire-at>2022-08-23T05:34:51Z</expire-at><entry><content>content_18xa3g0208</content></entry></data> 2022-08-22 22:34:46 | target: http://localhost:8088 2022-08-22 22:34:46 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-08-22 22:34:46 | entity: <data><node>node_8d602i0204</node><expire-at>2022-08-23T05:34:51Z</expire-at><entry><content>content_18xa3g0208</content></entry></data> 2022-08-22 22:34:46 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Tue, 23 Aug 2022 05:34:46 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-08-22 22:34:46 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>1e777710-dad9-4b2b-8459-33d6105701f5</value></item-id></result> 2022-08-22 22:34:46 | contains: true 2022-08-22 22:34:54 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-22 22:34:54 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222 2022-08-22 22:34:54 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-08-22 22:34:55 | [Mutex] waiting for: [user_regularazf3rf0203@test-domain.com:message:received:content_18xa3g0208] 2022-08-22 22:35:10 | [Mutex] timeout. Not received [user_regularazf3rf0203@test-domain.com:message:received:content_18xa3g0208] 2022-08-22 22:35:10 | [Mutex] received everything. 2022-08-22 22:35:10 | [Mutex] isItemNotified: user_regularazf3rf0203@test-domain.com:message:received:content_18xa3g0208 :: false 2022-08-22 22:35:10 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_18xa3g0208 :: true |