XEP-0357: Push Notifications

Test duration: 282,757s

Passed Tests
tigase.tests.server.TestPush
testAutomaticDisablingOnFailure 31,131s
2020-07-23 11:18:09 |

2020-07-23 11:18:09 | null / [TestClass name=class tigase.tests.server.TestPush]

2020-07-23 11:18:09 | ------------------------------------

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:18:09 | [Mutex] received everything.

2020-07-23 11:18:09 | [Mutex] isItemNotified: discovery:completed:success :: true

2020-07-23 11:18:09 | [Mutex] isItemNotified: discovery:identity:account:registered :: true

2020-07-23 11:18:09 | [Mutex] isItemNotified: discovery:feature:urn:xmpp:push:0 :: true

2020-07-23 11:18:09 | [Mutex] waiting for: [push:received:1]

2020-07-23 11:18:09 | [Mutex] received everything.

2020-07-23 11:18:09 | [Mutex] isItemNotified: push:received:1 :: true

2020-07-23 11:18:09 | [Mutex] isItemNotified: push:received:1:body:Some body 1 - 1e8c3913-06ec-4529-a033-8433953b9727 :: true

2020-07-23 11:18:09 | [Mutex] waiting for: [push:received:2]

2020-07-23 11:18:09 | [Mutex] received everything.

2020-07-23 11:18:09 | [Mutex] isItemNotified: push:received:2 :: true

2020-07-23 11:18:09 | [Mutex] isItemNotified: push:received:2:body:Some body 2 - bbe9a167-b5bd-4e2d-a6d0-8365fbb693d4 :: true

2020-07-23 11:18:10 | [Mutex] waiting for: [push:received:3]

2020-07-23 11:18:40 | [Mutex] timeout. Not received [push:received:3]

2020-07-23 11:18:40 | [Mutex] isItemNotified: push:received:3 :: false

2020-07-23 11:18:40 | [Mutex] isItemNotified: push:received:3:body:Some body 3 - d5976c40-3dda-4c77-98dd-a15894bdb6ea :: false

testPushDeliveryOffline 0,053s
2020-07-23 11:18:41 |

2020-07-23 11:18:41 | null / [TestClass name=class tigase.tests.server.TestPush]

2020-07-23 11:18:41 | ------------------------------------

2020-07-23 11:18:41 | [Mutex] waiting for: [push:received]

2020-07-23 11:18:41 | [Mutex] received everything.

2020-07-23 11:18:41 | [Mutex] isItemNotified: push:received :: true

2020-07-23 11:18:41 | [Mutex] isItemNotified: push:received:body:Some body - e924cd12-732a-4ddd-8faf-cfedd5ffa397 :: true

testPushDeliveryOnline 30,130s
2020-07-23 11:18:43 |

2020-07-23 11:18:43 | null / [TestClass name=class tigase.tests.server.TestPush]

2020-07-23 11:18:43 | ------------------------------------

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1wdXNoMS1fNnUybnRtMDA5OSxyPVB5U3l0NWNSdll2YXN5OTByRG9v</auth>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QeVN5dDVjUnZZdmFzeTkwckRvb0hybFZTNzNNOEVqcVNYVVJ4N3RELHM9ZElPaW5obDlUN2pRZlE9PSxpPTQwOTY=</challenge>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UHlTeXQ1Y1J2WXZhc3k5MHJEb29IcmxWUzczTThFanFTWFVSeDd0RCxwPVl0Tk5DWWlGc2Nhb1BXUEJkYmdHaVJYTmZnT2x4UDdpcFFZdGtrWmpJQ0U9</response>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ZbDU3RWJqWU9SZzJJSGlRTU8rVkxTRE9HS0QwTVpPMTVSR3VDVFFFbXNBPQ==</success>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="pCbyYw6WQMV9JZsgxhKgKbfyQak="/></features>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com >> <iq xmlns="jabber:client" id="JdIiGKDmTgxiWezrgGzDvex" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com << <iq id="JdIiGKDmTgxiWezrgGzDvex" to="push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96</jid></bind></iq>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 >> <iq xmlns="jabber:client" id="96lOKu6iGKDmTgxiWezrgGz" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 << <iq id="96lOKu6iGKDmTgxiWezrgGz" to="push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96" xmlns="jabber:client" type="result"/>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 >> <iq to="test-domain.com" id="shQFPT05hLP2m9sUasUWY2s" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 >> <iq id="5wx8Hy6yes2aqeBiL01gS6j" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 << <enabled id="7dcca9e2-4bf6-4bc2-9b85-089eded5df49" location="localhost" resume="true" max="60" xmlns="urn:xmpp:sm:3"/>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 << <iq id="shQFPT05hLP2m9sUasUWY2s" from="test-domain.com" to="push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-b10857/dbf58aae" category="component" type="router"/><identity name="Tigase ver. 8.1.0-b10857/dbf58aae" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 << <iq id="5wx8Hy6yes2aqeBiL01gS6j" to="push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 << <presence from="push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96" to="push1-_6u2ntm0099@test-domain.com" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-07-23 11:18:43 | [Mutex] waiting for: [push:received]

2020-07-23 11:18:43 | push1- :: push1-_6u2ntm0099@test-domain.com/1204607085-tigase-96 << <message from="push2-_o3ylfy0101@test-domain.com/1204607085-tigase-95" to="push1-_6u2ntm0099@test-domain.com" xmlns="jabber:client"><body>Some body - e9aeaea6-506e-44ea-aaac-3907e665b1c5</body></message>

2020-07-23 11:19:13 | [Mutex] timeout. Not received [push:received]

2020-07-23 11:19:13 | [Mutex] isItemNotified: push:received :: false

testPushDeliveryOnlineAway 30,470s
2020-07-23 11:19:14 |

2020-07-23 11:19:14 | null / [TestClass name=class tigase.tests.server.TestPush]

2020-07-23 11:19:14 | ------------------------------------

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2096f88d

2020-07-23 11:19:14 | StateChangedEvent{oldState=null, newState=connecting}

2020-07-23 11:19:14 | [Mutex] waiting for: [registration]

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2e5112ef

2020-07-23 11:19:14 | StateChangedEvent{oldState=connecting, newState=connected}

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2a6e93fd

2020-07-23 11:19:14 | push3- :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-07-23 11:19:14 | StanzaReceivedEvent{stanza=<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>}

2020-07-23 11:19:14 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2020-07-23 11:19:14 | push3- :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-07-23 11:19:14 | StanzaSendingEvent{stanza=<starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>}

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@6f6c18d4

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7829d724

2020-07-23 11:19:14 | push3- :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-07-23 11:19:14 | StanzaReceivedEvent{stanza=<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>}

2020-07-23 11:19:14 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2020-07-23 11:19:14 | push3- :: null >> <iq to="test-domain.com" id="KB2WgFq1w3k0mPXiKHT1gBj" type="get"><query xmlns="jabber:iq:register"/></iq>

2020-07-23 11:19:14 | StanzaSendingEvent{stanza=<iq to="test-domain.com" id="KB2WgFq1w3k0mPXiKHT1gBj" type="get"><query xmlns="jabber:iq:register"/></iq>}

2020-07-23 11:19:14 | push3- :: null << <iq id="KB2WgFq1w3k0mPXiKHT1gBj" from="test-domain.com" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x xmlns="jabber:x:data" type="form"><title>Account Registration</title><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field label="Username" var="username" type="text-single"><required/><value/></field><field label="Password" var="password" type="text-private"><required/><value/></field><field label="Email (MUST BE VALID!)" var="email" type="text-single"><required/><value/></field></x></query></iq>

2020-07-23 11:19:14 | StanzaReceivedEvent{stanza=<iq id="KB2WgFq1w3k0mPXiKHT1gBj" from="test-domain.com" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x xmlns="jabber:x:data" type="form"><title>Account Registration</title><instructions>Choose a user name and password for use with this service.

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field label="Username" var="username" type="text-single"><required/><value/></field><field label="Password" var="password" type="text-private"><required/><value/></field><field label="Email (MUST BE VALID!)" var="email" type="text-single"><required/><value/></field></x></query></iq>}

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5e4974a4

2020-07-23 11:19:14 | push3- :: null >> <iq to="test-domain.com" id="FwLEqQOIwqZ4j6dEEEp7CoZ" type="set"><query xmlns="jabber:iq:register"><username>push3-_a4e5xq0105</username><password>push3-_a4e5xq0105</password><email>374a745a-e1be-4484-b575-c95c6cfef3bd@localhost</email></query></iq>

2020-07-23 11:19:14 | StanzaSendingEvent{stanza=<iq to="test-domain.com" id="FwLEqQOIwqZ4j6dEEEp7CoZ" type="set"><query xmlns="jabber:iq:register"><username>push3-_a4e5xq0105</username><password>push3-_a4e5xq0105</password><email>374a745a-e1be-4484-b575-c95c6cfef3bd@localhost</email></query></iq>}

2020-07-23 11:19:14 | push3- :: null << <iq id="FwLEqQOIwqZ4j6dEEEp7CoZ" from="test-domain.com" xmlns="jabber:client" type="result"/>

2020-07-23 11:19:14 | StanzaReceivedEvent{stanza=<iq id="FwLEqQOIwqZ4j6dEEEp7CoZ" from="test-domain.com" xmlns="jabber:client" type="result"/>}

2020-07-23 11:19:14 | [Mutex] received everything.

2020-07-23 11:19:14 | [Mutex] isItemNotified: registrationSuccess :: true

2020-07-23 11:19:14 | StateChangedEvent{oldState=connected, newState=disconnecting}

2020-07-23 11:19:14 | StateChangedEvent{oldState=disconnecting, newState=disconnected}

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@e6e5eb

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@f43e79b

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@39e591a0

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2c9c3e6c

2020-07-23 11:19:14 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1be24fa9

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1wdXNoMy1fYTRlNXhxMDEwNSxyPXl4dWc0RUxDOUpHWGRlc1dwenlv</auth>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15eHVnNEVMQzlKR1hkZXNXcHp5b2tWQUswdGZpZzJyMjNGUldMRkRSLHM9QmpRMGlqYVpocWRhclE9PSxpPTQwOTY=</challenge>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eXh1ZzRFTEM5SkdYZGVzV3B6eW9rVkFLMHRmaWcycjIzRlJXTEZEUixwPVc4WUw5SG9FclA1RTFNVDNsd2lpLzRGaUJsdGZqdGZ6Zzd2cFlFVFh6MTg9</response>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ZWUJNeXVSYndYMHZSbmJrTEczSDN1dDR6SmMvRXREdTFZRU1wbnkxcGo0PQ==</success>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="pCbyYw6WQMV9JZsgxhKgKbfyQak="/></features>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com >> <iq xmlns="jabber:client" id="2E7dJQYnUOY48oSQ4hEtqRW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com << <iq id="2E7dJQYnUOY48oSQ4hEtqRW" to="push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100</jid></bind></iq>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 >> <iq xmlns="jabber:client" id="KE52s3czCfIMUV9GwfZdEnR" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 << <iq id="KE52s3czCfIMUV9GwfZdEnR" to="push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100" xmlns="jabber:client" type="result"/>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 >> <iq to="test-domain.com" id="IzOw8m6lMJWT0m4fNY6pjRW" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 >> <iq id="9APMGmQMEGv6netaGIxn8q3" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 << <enabled id="7fd40c9f-9bd9-4c63-9207-8ca801f33106" location="localhost" resume="true" max="60" xmlns="urn:xmpp:sm:3"/>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 << <iq id="IzOw8m6lMJWT0m4fNY6pjRW" from="test-domain.com" to="push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-b10857/dbf58aae" category="component" type="router"/><identity name="Tigase ver. 8.1.0-b10857/dbf58aae" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 << <iq id="9APMGmQMEGv6netaGIxn8q3" to="push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 << <presence from="push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100" to="push3-_a4e5xq0105@test-domain.com" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 >> <iq id="hKhq1w3k0mPXiKHT1gBjPXi" type="set"><enable xmlns="urn:xmpp:push:0" node="test-node" jid="push-component-_dcnaa00103@test-domain.com/1204607085-tigase-98"/></iq>

2020-07-23 11:19:14 | [Mutex] waiting for: [push:enabled]

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 << <iq id="hKhq1w3k0mPXiKHT1gBjPXi" to="push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100" xmlns="jabber:client" type="result"/>

2020-07-23 11:19:14 | [Mutex] received everything.

2020-07-23 11:19:14 | [Mutex] isItemNotified: push:enabled:success :: true

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 >> <presence><show>xa</show><priority>10</priority><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-07-23 11:19:14 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 << <presence from="push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100" to="push3-_a4e5xq0105@test-domain.com" xmlns="jabber:client"><show>xa</show><priority>10</priority><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-07-23 11:19:15 | [Mutex] waiting for: [push:received]

2020-07-23 11:19:15 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 << <message from="push2-_5ujeot0104@test-domain.com/1204607085-tigase-99" to="push3-_a4e5xq0105@test-domain.com" xmlns="jabber:client"><body>Some body - 131fe398-4f01-49d0-a114-cd71566668d9</body></message>

2020-07-23 11:19:45 | [Mutex] timeout. Not received [push:received]

2020-07-23 11:19:45 | [Mutex] isItemNotified: push:received :: false

2020-07-23 11:19:45 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 >> <iq id="hKhq1w3k0mPXiKHT1gBjPXi" type="set"><enable xmlns="urn:xmpp:push:0" node="test-node" away="true" jid="push-component-_dcnaa00103@test-domain.com/1204607085-tigase-98"/></iq>

2020-07-23 11:19:45 | [Mutex] waiting for: [push:enabled:2]

2020-07-23 11:19:45 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 << <iq id="hKhq1w3k0mPXiKHT1gBjPXi" to="push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100" xmlns="jabber:client" type="result"/>

2020-07-23 11:19:45 | [Mutex] received everything.

2020-07-23 11:19:45 | [Mutex] isItemNotified: push:enabled:2:success :: true

2020-07-23 11:19:45 | [Mutex] waiting for: [push:received]

2020-07-23 11:19:45 | push3- :: push3-_a4e5xq0105@test-domain.com/1204607085-tigase-100 << <message from="push2-_5ujeot0104@test-domain.com/1204607085-tigase-99" to="push3-_a4e5xq0105@test-domain.com" xmlns="jabber:client"><body>Some body - 131fe398-4f01-49d0-a114-cd71566668d9</body></message>

2020-07-23 11:19:45 | [Mutex] received everything.

2020-07-23 11:19:45 | [Mutex] isItemNotified: push:received :: true

2020-07-23 11:19:45 | [Mutex] isItemNotified: push:received:body:Some body - 131fe398-4f01-49d0-a114-cd71566668d9 :: true

testSupportAdvertisement 0,133s
2020-07-23 11:19:46 |

2020-07-23 11:19:46 | null / [TestClass name=class tigase.tests.server.TestPush]

2020-07-23 11:19:46 | ------------------------------------

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1wdXNoMS1fdTE2bXV1MDEwNixyPUdXYjFDRklCd1dCdlZzT1JiYjg3</auth>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HV2IxQ0ZJQndXQnZWc09SYmI4N0IyVGZKTUs0OGE4TVBXTXZGWjRYLHM9RkZIdkY4KzVOZlJnSlE9PSxpPTQwOTY=</challenge>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R1diMUNGSUJ3V0J2VnNPUmJiODdCMlRmSk1LNDhhOE1QV012Rlo0WCxwPSt4Z0pUeG14SlhCSjBWYWMrY3RDZkNyZlJpY3RwT0MzbmZUM01Jc2xYeWM9</response>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj01ZFZ0VnExNDNwSlN5MnhOUUo0YmZ4WmJRdGFJMUdUL2lBNFFjaFd6N2lnPQ==</success>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="pCbyYw6WQMV9JZsgxhKgKbfyQak="/></features>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com >> <iq xmlns="jabber:client" id="f5wcxavuZcKQNTaubRX8lNN" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com << <iq id="f5wcxavuZcKQNTaubRX8lNN" to="push1-_u16muu0106@test-domain.com/1204607085-tigase-104" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>push1-_u16muu0106@test-domain.com/1204607085-tigase-104</jid></bind></iq>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 >> <iq xmlns="jabber:client" id="R1iAwoT5ygJX9w7lT5yodAa" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 << <iq id="R1iAwoT5ygJX9w7lT5yodAa" to="push1-_u16muu0106@test-domain.com/1204607085-tigase-104" xmlns="jabber:client" type="result"/>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 >> <iq to="test-domain.com" id="BprVhIqcw2cu4wbs5EjQ2qX" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 >> <iq id="x7xW5tkWjMys24gCk2dwdUP" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 << <enabled id="312200d0-2425-4347-970a-681783489ead" location="localhost" resume="true" max="60" xmlns="urn:xmpp:sm:3"/>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 << <iq id="BprVhIqcw2cu4wbs5EjQ2qX" from="test-domain.com" to="push1-_u16muu0106@test-domain.com/1204607085-tigase-104" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-b10857/dbf58aae" category="component" type="router"/><identity name="Tigase ver. 8.1.0-b10857/dbf58aae" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 << <iq id="x7xW5tkWjMys24gCk2dwdUP" to="push1-_u16muu0106@test-domain.com/1204607085-tigase-104" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 << <presence from="push1-_u16muu0106@test-domain.com/1204607085-tigase-104" to="push1-_u16muu0106@test-domain.com" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 >> <iq to="push1-_u16muu0106@test-domain.com" id="QxLiOYiHHMIDLLKzfHHMQ7o" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | push1- :: push1-_u16muu0106@test-domain.com/1204607085-tigase-104 << <iq id="QxLiOYiHHMIDLLKzfHHMQ7o" from="push1-_u16muu0106@test-domain.com" to="push1-_u16muu0106@test-domain.com/1204607085-tigase-104" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="account" type="registered"/><identity name="PubSub" category="pubsub" type="service"/><feature var="http://jabber.org/protocol/pubsub#retrieve-default"/><feature var="http://jabber.org/protocol/pubsub#purge-nodes"/><feature var="http://jabber.org/protocol/pubsub#subscribe"/><feature var="http://jabber.org/protocol/pubsub#member-affiliation"/><feature var="http://jabber.org/protocol/pubsub#subscription-notifications"/><feature var="http://jabber.org/protocol/pubsub#create-nodes"/><feature var="http://jabber.org/protocol/pubsub#outcast-affiliation"/><feature var="http://jabber.org/protocol/pubsub#get-pending"/><feature var="http://jabber.org/protocol/pubsub#presence-notifications"/><feature var="urn:xmpp:ping"/><feature var="http://jabber.org/protocol/pubsub#delete-nodes"/><feature var="http://jabber.org/protocol/pubsub#config-node"/><feature var="http://jabber.org/protocol/pubsub#retrieve-items"/><feature var="http://jabber.org/protocol/pubsub#access-whitelist"/><feature var="http://jabber.org/protocol/pubsub#access-presence"/><feature var="urn:xmpp:mam:1"/><feature var="http://jabber.org/protocol/pubsub#instant-nodes"/><feature var="http://jabber.org/protocol/pubsub#modify-affiliations"/><feature var="http://jabber.org/protocol/pubsub#multi-collection"/><feature var="http://jabber.org/protocol/pubsub#create-and-configure"/><feature var="http://jabber.org/protocol/pubsub#publisher-affiliation"/><feature var="http://jabber.org/protocol/pubsub#access-open"/><feature var="http://jabber.org/protocol/pubsub#retrieve-affiliations"/><feature var="http://jabber.org/protocol/pubsub#access-authorize"/><feature var="jabber:iq:version"/><feature var="http://jabber.org/protocol/pubsub#retract-items"/><feature var="http://jabber.org/protocol/pubsub#manage-subscriptions"/><feature var="tigase:pubsub:1"/><feature var="http://jabber.org/protocol/commands"/><feature var="http://jabber.org/protocol/pubsub#auto-subscribe"/><feature var="http://jabber.org/protocol/pubsub#publish-options"/><feature var="http://jabber.org/protocol/pubsub#access-roster"/><feature var="http://jabber.org/protocol/pubsub#publish"/><feature var="http://jabber.org/protocol/pubsub#collections"/><feature var="http://jabber.org/protocol/pubsub#retrieve-subscriptions"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="http://jabber.org/protocol/pubsub#auto-create"/><feature var="http://jabber.org/protocol/pubsub#auto-subscribe"/><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:46 | [Mutex] received everything.

2020-07-23 11:19:46 | [Mutex] isItemNotified: discovery:completed:success :: true

2020-07-23 11:19:46 | [Mutex] isItemNotified: discovery:identity:account:registered :: true

2020-07-23 11:19:46 | [Mutex] isItemNotified: discovery:feature:urn:xmpp:push:0 :: true

tigase.tests.server.TestPushEncryped
testPushDeliveryOffline 0,084s
2020-07-23 11:21:49 |

2020-07-23 11:21:49 | null / [TestClass name=class tigase.tests.server.TestPushEncryped]

2020-07-23 11:21:49 | ------------------------------------

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:49 | [Mutex] received everything.

2020-07-23 11:21:49 | [Mutex] isItemNotified: discovery:completed:success :: true

2020-07-23 11:21:49 | [Mutex] isItemNotified: discovery:identity:account:registered :: true

2020-07-23 11:21:49 | [Mutex] isItemNotified: discovery:feature:urn:xmpp:push:0 :: true

2020-07-23 11:21:49 | [Mutex] isItemNotified: discovery:feature:tigase:push:encrypt:0 :: true

2020-07-23 11:21:49 | [Mutex] waiting for: [push:received]

2020-07-23 11:21:50 | [Mutex] received everything.

2020-07-23 11:21:50 | [Mutex] isItemNotified: push:received :: true

2020-07-23 11:21:50 | [Mutex] isItemNotified: push:received:body:Some body - 406e53b5-eb11-4c66-b884-c4210be66b46 :: true

testPushDeliveryOnline 30,161s
2020-07-23 11:21:50 |

2020-07-23 11:21:50 | null / [TestClass name=class tigase.tests.server.TestPushEncryped]

2020-07-23 11:21:50 | ------------------------------------

2020-07-23 11:21:50 | [Mutex] waiting for: [push:received]

2020-07-23 11:22:20 | [Mutex] timeout. Not received [push:received]

2020-07-23 11:22:20 | [Mutex] isItemNotified: push:received :: false

testPushDeliveryOnlineAway 30,228s
2020-07-23 11:22:20 |

2020-07-23 11:22:20 | null / [TestClass name=class tigase.tests.server.TestPushEncryped]

2020-07-23 11:22:20 | ------------------------------------

2020-07-23 11:22:20 | [Mutex] waiting for: [push:enabled]

2020-07-23 11:22:20 | [Mutex] received everything.

2020-07-23 11:22:20 | [Mutex] isItemNotified: push:enabled:success :: true

2020-07-23 11:22:20 | [Mutex] waiting for: [push:received]

2020-07-23 11:22:50 | [Mutex] timeout. Not received [push:received]

2020-07-23 11:22:50 | [Mutex] isItemNotified: push:received :: false

2020-07-23 11:22:50 | [Mutex] waiting for: [push:enabled]

2020-07-23 11:22:50 | [Mutex] received everything.

2020-07-23 11:22:50 | [Mutex] isItemNotified: push:enabled:success :: true

2020-07-23 11:22:50 | [Mutex] waiting for: [push:received]

2020-07-23 11:22:50 | [Mutex] received everything.

2020-07-23 11:22:50 | [Mutex] isItemNotified: push:received :: true

2020-07-23 11:22:50 | [Mutex] isItemNotified: push:received:body:Some body - 89b857d2-c360-45fe-86f9-954806ec5785 :: true

testSupportAdvertisement 0,025s
2020-07-23 11:22:50 |

2020-07-23 11:22:50 | null / [TestClass name=class tigase.tests.server.TestPushEncryped]

2020-07-23 11:22:50 | ------------------------------------

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:22:50 | [Mutex] received everything.

2020-07-23 11:22:50 | [Mutex] isItemNotified: discovery:completed:success :: true

2020-07-23 11:22:50 | [Mutex] isItemNotified: discovery:identity:account:registered :: true

2020-07-23 11:22:50 | [Mutex] isItemNotified: discovery:feature:urn:xmpp:push:0 :: true

2020-07-23 11:22:50 | [Mutex] isItemNotified: discovery:feature:tigase:push:encrypt:0 :: true

2020-07-23 11:22:50 | [Mutex] isItemNotified: discovery:feature:tigase:push:encrypt:aes-128-gcm :: true

tigase.tests.server.TestPushMuted
testPushDeliveryOffline 30,022s
2020-07-23 11:19:48 |

2020-07-23 11:19:48 | null / [TestClass name=class tigase.tests.server.TestPushMuted]

2020-07-23 11:19:48 | ------------------------------------

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:19:48 | [Mutex] received everything.

2020-07-23 11:19:48 | [Mutex] isItemNotified: discovery:completed:success :: true

2020-07-23 11:19:48 | [Mutex] isItemNotified: discovery:identity:account:registered :: true

2020-07-23 11:19:48 | [Mutex] isItemNotified: discovery:feature:urn:xmpp:push:0 :: true

2020-07-23 11:19:48 | [Mutex] isItemNotified: discovery:feature:tigase:push:filter:muted:0 :: true

2020-07-23 11:19:48 | [Mutex] waiting for: [push:received]

2020-07-23 11:20:18 | [Mutex] timeout. Not received [push:received]

2020-07-23 11:20:18 | [Mutex] isItemNotified: push:received :: false

testPushDeliveryOnline 30,129s
2020-07-23 11:20:18 |

2020-07-23 11:20:18 | null / [TestClass name=class tigase.tests.server.TestPushMuted]

2020-07-23 11:20:18 | ------------------------------------

2020-07-23 11:20:18 | [Mutex] waiting for: [push:received]

2020-07-23 11:20:48 | [Mutex] timeout. Not received [push:received]

2020-07-23 11:20:48 | [Mutex] isItemNotified: push:received :: false

testPushDeliveryOnlineAway 60,129s
2020-07-23 11:20:48 |

2020-07-23 11:20:48 | null / [TestClass name=class tigase.tests.server.TestPushMuted]

2020-07-23 11:20:48 | ------------------------------------

2020-07-23 11:20:48 | [Mutex] waiting for: [push:enabled]

2020-07-23 11:20:48 | [Mutex] received everything.

2020-07-23 11:20:48 | [Mutex] isItemNotified: push:enabled:success :: true

2020-07-23 11:20:48 | [Mutex] waiting for: [push:received]

2020-07-23 11:21:18 | [Mutex] timeout. Not received [push:received]

2020-07-23 11:21:18 | [Mutex] isItemNotified: push:received :: false

2020-07-23 11:21:18 | [Mutex] waiting for: [push:enabled]

2020-07-23 11:21:18 | [Mutex] received everything.

2020-07-23 11:21:18 | [Mutex] isItemNotified: push:enabled:success :: true

2020-07-23 11:21:18 | [Mutex] waiting for: [push:received]

2020-07-23 11:21:48 | [Mutex] timeout. Not received [push:received]

2020-07-23 11:21:48 | [Mutex] isItemNotified: push:received :: false

testSupportAdvertisement 0,019s
2020-07-23 11:21:48 |

2020-07-23 11:21:48 | null / [TestClass name=class tigase.tests.server.TestPushMuted]

2020-07-23 11:21:48 | ------------------------------------

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] waiting for: [discovery:completed]

2020-07-23 11:21:48 | [Mutex] received everything.

2020-07-23 11:21:48 | [Mutex] isItemNotified: discovery:completed:success :: true

2020-07-23 11:21:48 | [Mutex] isItemNotified: discovery:identity:account:registered :: true

2020-07-23 11:21:48 | [Mutex] isItemNotified: discovery:feature:urn:xmpp:push:0 :: true

2020-07-23 11:21:48 | [Mutex] isItemNotified: discovery:feature:tigase:push:filter:muted:0 :: true