Suites ยท Log Output
Test duration : 44.889s
Passed Tests | ||
---|---|---|
tigase.tests.pubsub.TestRestApiWithMessageExpiration | ||
testMessageExpiration | 43.609s |
2022-06-01 22:41:01 |
2022-06-01 22:41:01 | null / [TestClass name=class tigase.tests.pubsub.TestRestApiWithMessageExpiration] 2022-06-01 22:41:01 | ------------------------------------ 2022-06-01 22:41:01 | [Mutex] isItemNotified: node_v5etxm0204:exists :: false 2022-06-01 22:41:01 | [Mutex] waiting for: [node_v5etxm0204:create_node] 2022-06-01 22:41:01 | [Mutex] received everything. 2022-06-01 22:41:01 | [Mutex] isItemNotified: node_v5etxm0204:create_node:success :: true 2022-06-01 22:41:01 | [Mutex] waiting for: [node_v5etxm0204:subscribe_node] 2022-06-01 22:41:01 | [Mutex] received everything. 2022-06-01 22:41:01 | [Mutex] isItemNotified: node_v5etxm0204:subscribe_node:success :: true 2022-06-01 22:41:01 | ===== publishing normal message (to online) 2022-06-01 22:41:01 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-06-01 22:41:01 | command: <data><node>node_v5etxm0204</node><entry><content>content_ni0a2j0205</content></entry></data> 2022-06-01 22:41:01 | target: http://localhost:8088 2022-06-01 22:41:01 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-06-01 22:41:01 | entity: <data><node>node_v5etxm0204</node><entry><content>content_ni0a2j0205</content></entry></data> 2022-06-01 22:41:01 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 02 Jun 2022 05:41:01 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-06-01 22:41:01 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>aa80e204-c695-411e-8feb-d496e6029295</value></item-id></result> 2022-06-01 22:41:01 | contains: true 2022-06-01 22:41:01 | [Mutex] received everything. 2022-06-01 22:41:01 | [Mutex] isItemNotified: user_regularliwb6w0203@test-domain.com:message:received:content_ni0a2j0205 :: true 2022-06-01 22:41:01 | ===== publishing already old message - expecting message being filtered out (to online) 2022-06-01 22:41:01 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-06-01 22:41:01 | command: <data><node>node_v5etxm0204</node><expire-at>2022-06-02T05:40:56Z</expire-at><entry><content>content_x0bi6w0206</content></entry></data> 2022-06-01 22:41:01 | target: http://localhost:8088 2022-06-01 22:41:01 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-06-01 22:41:01 | entity: <data><node>node_v5etxm0204</node><expire-at>2022-06-02T05:40:56Z</expire-at><entry><content>content_x0bi6w0206</content></entry></data> 2022-06-01 22:41:01 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 02 Jun 2022 05:41:01 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-06-01 22:41:01 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>c68b603d-8887-4a3a-9d87-47aa09153293</value></item-id></result> 2022-06-01 22:41:01 | contains: true 2022-06-01 22:41:01 | [Mutex] waiting for: [user_regularliwb6w0203@test-domain.com:message:received:content_x0bi6w0206] 2022-06-01 22:41:16 | [Mutex] timeout. Not received [user_regularliwb6w0203@test-domain.com:message:received:content_x0bi6w0206] 2022-06-01 22:41:16 | [Mutex] isItemNotified: user_regularliwb6w0203@test-domain.com:message:received:content_x0bi6w0206 :: false 2022-06-01 22:41:16 | ===== publishing normal message (to offline) 2022-06-01 22:41:16 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-06-01 22:41:16 | command: <data><node>node_v5etxm0204</node><entry><content>content_w5aopl0207</content></entry></data> 2022-06-01 22:41:16 | target: http://localhost:8088 2022-06-01 22:41:16 | entity: [Content-Type: application/xml,Content-Length: 93,Chunked: false] 2022-06-01 22:41:16 | entity: <data><node>node_v5etxm0204</node><entry><content>content_w5aopl0207</content></entry></data> 2022-06-01 22:41:16 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 02 Jun 2022 05:41:16 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-06-01 22:41:16 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>e9fe7d0d-b88c-406e-a0ce-f505246dd716</value></item-id></result> 2022-06-01 22:41:16 | contains: true 2022-06-01 22:41:21 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-06-01 22:41:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] DNS entry stored in session object: localhost:5222 2022-06-01 22:41:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=480 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-06-01 22:41:21 | [Mutex] waiting for: [user_regularliwb6w0203@test-domain.com:message:received:content_w5aopl0207] 2022-06-01 22:41:21 | [Mutex] waiting for: [user_regularliwb6w0203@test-domain.com:message:received:content_w5aopl0207] 2022-06-01 22:41:21 | [Mutex] received everything. 2022-06-01 22:41:21 | [Mutex] isItemNotified: user_regularliwb6w0203@test-domain.com:message:received:content_w5aopl0207 :: true 2022-06-01 22:41:21 | ===== publishing already old message - expecting message being filtered out (to offline) 2022-06-01 22:41:21 | [Mutex] received everything. 2022-06-01 22:41:21 | [Mutex] isItemNotified: node_v5etxm0204:subscribe_node:success :: true 2022-06-01 22:41:21 | postRequest: POST /rest/pubsub/pubsub.test-domain.com/publish-item HTTP/1.1 2022-06-01 22:41:21 | command: <data><node>node_v5etxm0204</node><expire-at>2022-06-02T05:41:26Z</expire-at><entry><content>content_ssqnlm0208</content></entry></data> 2022-06-01 22:41:21 | target: http://localhost:8088 2022-06-01 22:41:21 | entity: [Content-Type: application/xml,Content-Length: 136,Chunked: false] 2022-06-01 22:41:21 | entity: <data><node>node_v5etxm0204</node><expire-at>2022-06-02T05:41:26Z</expire-at><entry><content>content_ssqnlm0208</content></entry></data> 2022-06-01 22:41:21 | response: HttpResponseProxy{HTTP/1.1 200 OK [Date: Thu, 02 Jun 2022 05:41:21 GMT, Transfer-encoding: chunked] ResponseEntityProxy{[Chunked: true]}} 2022-06-01 22:41:21 | response entity: <result><Note type="fixed"><value>Operation successful</value></Note><item-id type="fixed" label="Item ID"><value>138eb57b-31ff-4ce7-9a4c-343c659903dd</value></item-id></result> 2022-06-01 22:41:21 | contains: true 2022-06-01 22:41:29 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-06-01 22:41:29 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] DNS entry stored in session object: localhost:5222 2022-06-01 22:41:29 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=481 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-06-01 22:41:30 | [Mutex] waiting for: [user_regularliwb6w0203@test-domain.com:message:received:content_ssqnlm0208] 2022-06-01 22:41:45 | [Mutex] timeout. Not received [user_regularliwb6w0203@test-domain.com:message:received:content_ssqnlm0208] 2022-06-01 22:41:45 | [Mutex] received everything. 2022-06-01 22:41:45 | [Mutex] isItemNotified: user_regularliwb6w0203@test-domain.com:message:received:content_ssqnlm0208 :: false 2022-06-01 22:41:45 | [Mutex] isItemNotified: admin@test-domain.com:message:received:content_ssqnlm0208 :: true |