Test duration: 45.174s
Passed Tests | ||
---|---|---|
tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
testMessageExpiration | 43.628s |
2019-11-26 18:45:21 |
2019-11-26 18:45:21 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2019-11-26 18:45:21 | ------------------------------------ 2019-11-26 18:45:21 | [Mutex] isItemNotified: node_sxtnk20181:exists :: false 2019-11-26 18:45:21 | [Mutex] waiting for: [node_sxtnk20181:create_node] 2019-11-26 18:45:21 | [Mutex] received everything. 2019-11-26 18:45:21 | [Mutex] isItemNotified: node_sxtnk20181:create_node:success :: true 2019-11-26 18:45:21 | [Mutex] waiting for: [node_sxtnk20181:subscribe_node] 2019-11-26 18:45:21 | [Mutex] received everything. 2019-11-26 18:45:21 | [Mutex] isItemNotified: node_sxtnk20181:subscribe_node:success :: true 2019-11-26 18:45:21 | ===== publishing normal message (to online) 2019-11-26 18:45:21 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-26 18:45:21 | command: <data><node>node_sxtnk20181</node><entry><content>content_gtcidg0182</content></entry></data> 2019-11-26 18:45:21 | target: http://localhost:8088 2019-11-26 18:45:21 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2019-11-26 18:45:21 | entity: <data><node>node_sxtnk20181</node><entry><content>content_gtcidg0182</content></entry></data> 2019-11-26 18:45:21 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 27 Nov 2019 02:45:21 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-26 18:45:21 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>9d45fa48-de22-40ab-8b99-d4fdd0d455cd</value></item-id></result> 2019-11-26 18:45:21 | contains: true 2019-11-26 18:45:21 | [Mutex] received everything. 2019-11-26 18:45:21 | [Mutex] isItemNotified: user_regularat858g0180@localhost:message:received:content_gtcidg0182 :: true 2019-11-26 18:45:21 | ===== publishing already old message - expecting message being filtered out (to online) 2019-11-26 18:45:21 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-26 18:45:21 | command: <data><node>node_sxtnk20181</node><expire-at>2019-11-27T02:45:16Z</expire-at><entry><content>content_5hj7300183</content></entry></data> 2019-11-26 18:45:21 | target: http://localhost:8088 2019-11-26 18:45:21 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2019-11-26 18:45:21 | entity: <data><node>node_sxtnk20181</node><expire-at>2019-11-27T02:45:16Z</expire-at><entry><content>content_5hj7300183</content></entry></data> 2019-11-26 18:45:21 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 27 Nov 2019 02:45:21 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-26 18:45:21 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>0081fe5f-200f-4bc0-807c-dcf9e9061c1e</value></item-id></result> 2019-11-26 18:45:21 | contains: true 2019-11-26 18:45:21 | [Mutex] waiting for: [user_regularat858g0180@localhost:message:received:content_5hj7300183] 2019-11-26 18:45:36 | [Mutex] timeout. Not received [user_regularat858g0180@localhost:message:received:content_5hj7300183] 2019-11-26 18:45:36 | [Mutex] isItemNotified: user_regularat858g0180@localhost:message:received:content_5hj7300183 :: false 2019-11-26 18:45:36 | ===== publishing normal message (to offline) 2019-11-26 18:45:36 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-26 18:45:36 | command: <data><node>node_sxtnk20181</node><entry><content>content_otxqv0184</content></entry></data> 2019-11-26 18:45:36 | target: http://localhost:8088 2019-11-26 18:45:36 | entity: [Content-Type: application/xml,Content-Length: 92,Chunked: false] 2019-11-26 18:45:36 | entity: <data><node>node_sxtnk20181</node><entry><content>content_otxqv0184</content></entry></data> 2019-11-26 18:45:36 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 27 Nov 2019 02:45:36 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-26 18:45:36 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>dc28ea06-37d9-4446-9877-e877a93b80d5</value></item-id></result> 2019-11-26 18:45:36 | contains: true 2019-11-26 18:45:41 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-26 18:45:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=454 thread=1] DNS entry stored in session object: localhost:5222 2019-11-26 18:45:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=454 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-26 18:45:41 | [Mutex] waiting for: [user_regularat858g0180@localhost:message:received:content_otxqv0184] 2019-11-26 18:45:41 | [Mutex] waiting for: [user_regularat858g0180@localhost:message:received:content_otxqv0184] 2019-11-26 18:45:41 | [Mutex] received everything. 2019-11-26 18:45:41 | [Mutex] isItemNotified: user_regularat858g0180@localhost:message:received:content_otxqv0184 :: true 2019-11-26 18:45:41 | ===== publishing already old message - expecting message being filtered out (to offline) 2019-11-26 18:45:41 | [Mutex] received everything. 2019-11-26 18:45:41 | [Mutex] isItemNotified: node_sxtnk20181:subscribe_node:success :: true 2019-11-26 18:45:41 | postRequest: POST /rest/pubsub/pubsub.localhost/publish-item HTTP/1.1 2019-11-26 18:45:41 | command: <data><node>node_sxtnk20181</node><expire-at>2019-11-27T02:45:46Z</expire-at><entry><content>content_bvmm870185</content></entry></data> 2019-11-26 18:45:41 | target: http://localhost:8088 2019-11-26 18:45:41 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2019-11-26 18:45:41 | entity: <data><node>node_sxtnk20181</node><expire-at>2019-11-27T02:45:46Z</expire-at><entry><content>content_bvmm870185</content></entry></data> 2019-11-26 18:45:41 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Wed, 27 Nov 2019 02:45:41 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2019-11-26 18:45:41 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id label="Item ID" type="fixed"><value>07c899b3-487e-40e3-bd0a-5769ba469870</value></item-id></result> 2019-11-26 18:45:41 | contains: true 2019-11-26 18:45:49 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-26 18:45:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=455 thread=1] DNS entry stored in session object: localhost:5222 2019-11-26 18:45:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=455 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-26 18:45:50 | [Mutex] waiting for: [user_regularat858g0180@localhost:message:received:content_bvmm870185] 2019-11-26 18:45:50 | [Mutex] waiting for: [user_regularat858g0180@localhost:message:received:content_bvmm870185] 2019-11-26 18:46:05 | [Mutex] timeout. Not received [user_regularat858g0180@localhost:message:received:content_bvmm870185] 2019-11-26 18:46:05 | [Mutex] received everything. 2019-11-26 18:46:05 | [Mutex] isItemNotified: user_regularat858g0180@localhost:message:received:content_bvmm870185 :: false 2019-11-26 18:46:05 | [Mutex] isItemNotified: admin@localhost:message:received:content_bvmm870185 :: true |