Test duration : 44.671s
Passed Tests | ||
---|---|---|
tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
testMessageExpiration | 43.546s |
2022-08-31 23:07:02 |
2022-08-31 23:07:02 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2022-08-31 23:07:02 | ------------------------------------ 2022-08-31 23:07:02 | [Mutex] isItemNotified: node_rwu6fh0204:exists :: false 2022-08-31 23:07:02 | [Mutex] waiting for: [node_rwu6fh0204:create_node] 2022-08-31 23:07:02 | [Mutex] received everything. 2022-08-31 23:07:02 | [Mutex] isItemNotified: node_rwu6fh0204:create_node:success :: true 2022-08-31 23:07:02 | [Mutex] waiting for: [node_rwu6fh0204:subscribe_node] 2022-08-31 23:07:02 | [Mutex] waiting for: [node_rwu6fh0204:subscribe_node] 2022-08-31 23:07:02 | [Mutex] received everything. 2022-08-31 23:07:02 | [Mutex] isItemNotified: node_rwu6fh0204:subscribe_node:success :: true 2022-08-31 23:07:02 | ===== publishing normal message (to online) 2022-08-31 23:07:02 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-08-31 23:07:02 | command: <data><node>node_rwu6fh0204</node><entry><content>content_6o9cih0205</content></entry></data> 2022-08-31 23:07:02 | target: http://localhost:8088 2022-08-31 23:07:02 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-08-31 23:07:02 | entity: <data><node>node_rwu6fh0204</node><entry><content>content_6o9cih0205</content></entry></data> 2022-08-31 23:07:02 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 01 Sep 2022 06:07:02 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-08-31 23:07:02 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>4fac17b2-7bd7-44d7-8252-bf90882ee4a8</value></item-id></result> 2022-08-31 23:07:02 | contains: true 2022-08-31 23:07:02 | [Mutex] received everything. 2022-08-31 23:07:02 | [Mutex] isItemNotified: user_regular5dmzi20203@test-domain.com:message:received:content_6o9cih0205 :: true 2022-08-31 23:07:02 | ===== publishing already old message - expecting message being filtered out (to online) 2022-08-31 23:07:02 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-08-31 23:07:02 | command: <data><node>node_rwu6fh0204</node><expire-at>2022-09-01T06:06:57Z</expire-at><entry><content>content_tzajbx0206</content></entry></data> 2022-08-31 23:07:02 | target: http://localhost:8088 2022-08-31 23:07:02 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-08-31 23:07:02 | entity: <data><node>node_rwu6fh0204</node><expire-at>2022-09-01T06:06:57Z</expire-at><entry><content>content_tzajbx0206</content></entry></data> 2022-08-31 23:07:02 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 01 Sep 2022 06:07:02 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-08-31 23:07:02 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>be66158f-75ec-4f53-8f8f-03e176a3abc7</value></item-id></result> 2022-08-31 23:07:02 | contains: true 2022-08-31 23:07:02 | [Mutex] waiting for: [user_regular5dmzi20203@test-domain.com:message:received:content_tzajbx0206] 2022-08-31 23:07:17 | [Mutex] timeout. Not received [user_regular5dmzi20203@test-domain.com:message:received:content_tzajbx0206] 2022-08-31 23:07:17 | [Mutex] isItemNotified: user_regular5dmzi20203@test-domain.com:message:received:content_tzajbx0206 :: false 2022-08-31 23:07:17 | ===== publishing normal message (to offline) 2022-08-31 23:07:17 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-08-31 23:07:17 | command: <data><node>node_rwu6fh0204</node><entry><content>content_3z0cfo0207</content></entry></data> 2022-08-31 23:07:17 | target: http://localhost:8088 2022-08-31 23:07:17 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-08-31 23:07:17 | entity: <data><node>node_rwu6fh0204</node><entry><content>content_3z0cfo0207</content></entry></data> 2022-08-31 23:07:17 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 01 Sep 2022 06:07:17 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-08-31 23:07:17 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>f613d1f5-43c2-40c2-8df7-d9567eff7f7f</value></item-id></result> 2022-08-31 23:07:17 | contains: true 2022-08-31 23:07:22 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-31 23:07:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] DNS entry stored in session object: localhost:5222 2022-08-31 23:07:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-08-31 23:07:22 | [Mutex] waiting for: [user_regular5dmzi20203@test-domain.com:message:received:content_3z0cfo0207] 2022-08-31 23:07:22 | [Mutex] received everything. 2022-08-31 23:07:22 | [Mutex] isItemNotified: user_regular5dmzi20203@test-domain.com:message:received:content_3z0cfo0207 :: true 2022-08-31 23:07:22 | ===== publishing already old message - expecting message being filtered out (to offline) 2022-08-31 23:07:22 | [Mutex] received everything. 2022-08-31 23:07:22 | [Mutex] isItemNotified: node_rwu6fh0204:subscribe_node:success :: true 2022-08-31 23:07:22 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-08-31 23:07:22 | command: <data><node>node_rwu6fh0204</node><expire-at>2022-09-01T06:07:27Z</expire-at><entry><content>content_2y6zn50208</content></entry></data> 2022-08-31 23:07:22 | target: http://localhost:8088 2022-08-31 23:07:22 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-08-31 23:07:22 | entity: <data><node>node_rwu6fh0204</node><expire-at>2022-09-01T06:07:27Z</expire-at><entry><content>content_2y6zn50208</content></entry></data> 2022-08-31 23:07:22 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 01 Sep 2022 06:07:22 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-08-31 23:07:22 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>4a0588c7-6708-4e8e-96fc-a750ca52a1cf</value></item-id></result> 2022-08-31 23:07:22 | contains: true 2022-08-31 23:07:30 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-31 23:07:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222 2022-08-31 23:07:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-08-31 23:07:30 | [Mutex] waiting for: [user_regular5dmzi20203@test-domain.com:message:received:content_2y6zn50208] 2022-08-31 23:07:45 | [Mutex] timeout. Not received [user_regular5dmzi20203@test-domain.com:message:received:content_2y6zn50208] 2022-08-31 23:07:45 | [Mutex] received everything. 2022-08-31 23:07:46 | [Mutex] isItemNotified: user_regular5dmzi20203@test-domain.com:message:received:content_2y6zn50208 :: false 2022-08-31 23:07:46 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_2y6zn50208 :: true |