Node and item manipulation using PubSub procotol - #4229

Test duration: 7.725s

Passed Tests
tigase.tests.pubsub.TestPubSub
configureNodes 1.071s
2017-11-29 09:33:21 |

2017-11-29 09:33:21 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:21 | ------------------------------------

2017-11-29 09:33:21 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="nwb2y8" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub#owner"><configure node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"><x xmlns="jabber:x:data" type="submit"><field type="text-single" var="pubsub#collection"><value>node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8</value></field></x></configure></pubsub></iq>

2017-11-29 09:33:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="nwb2y8" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub#owner"><configure node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"><x xmlns="jabber:x:data" type="submit"><field type="text-single" var="pubsub#collection"><value>node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8</value></field></x></configure></pubsub></iq>

2017-11-29 09:33:21 | [Mutex] waiting for: [configured:node:node-d171268e-097a-40b4-bc32-19c2a0310ef6:node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8]

2017-11-29 09:33:21 | [Mutex] received everything.

2017-11-29 09:33:21 | [Mutex] isItemNotified: configured:node:node-d171268e-097a-40b4-bc32-19c2a0310ef6:node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8 :: true

2017-11-29 09:33:22 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="onIAcG" type="get"><query xmlns="http://jabber.org/protocol/disco#items" node="node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8"/></iq>

2017-11-29 09:33:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="onIAcG" type="get"><query xmlns="http://jabber.org/protocol/disco#items" node="node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8"/></iq>

2017-11-29 09:33:22 | [Mutex] waiting for: [received:nodes:4a3848ea-39f1-4f0c-a492-303fa85f40a4:localhost]

2017-11-29 09:33:22 | [Mutex] received everything.

2017-11-29 09:33:22 | [Mutex] isItemNotified: received:node:4a3848ea-39f1-4f0c-a492-303fa85f40a4:localhost:node-d171268e-097a-40b4-bc32-19c2a0310ef6:Node d171268e-097a-40b4-bc32-19c2a0310ef6 :: true

2017-11-29 09:33:22 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="PFyWhB" type="get"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>

2017-11-29 09:33:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="PFyWhB" type="get"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>

2017-11-29 09:33:22 | [Mutex] received everything.

2017-11-29 09:33:22 | [Mutex] isItemNotified: received:node:2cc36a3d-8606-4032-9be8-6efa480540ad:localhost:node-d171268e-097a-40b4-bc32-19c2a0310ef6:Node d171268e-097a-40b4-bc32-19c2a0310ef6 :: false

createNodes 1.045s
2017-11-29 09:33:19 |

2017-11-29 09:33:19 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:19 | ------------------------------------

2017-11-29 09:33:19 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="7vgcLV" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><create node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"/><configure><x xmlns="jabber:x:data" type="submit"><field type="text-single" var="pubsub#title"><value>Node d171268e-097a-40b4-bc32-19c2a0310ef6</value></field></x></configure></pubsub></iq>

2017-11-29 09:33:19 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="7vgcLV" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><create node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"/><configure><x xmlns="jabber:x:data" type="submit"><field type="text-single" var="pubsub#title"><value>Node d171268e-097a-40b4-bc32-19c2a0310ef6</value></field></x></configure></pubsub></iq>

2017-11-29 09:33:19 | [Mutex] waiting for: [created:node:node-d171268e-097a-40b4-bc32-19c2a0310ef6:Node d171268e-097a-40b4-bc32-19c2a0310ef6]

2017-11-29 09:33:19 | [Mutex] received everything.

2017-11-29 09:33:19 | [Mutex] isItemNotified: created:node:node-d171268e-097a-40b4-bc32-19c2a0310ef6:Node d171268e-097a-40b4-bc32-19c2a0310ef6 :: true

2017-11-29 09:33:20 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="gGLl1j" type="get"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>

2017-11-29 09:33:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="gGLl1j" type="get"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>

2017-11-29 09:33:20 | [Mutex] waiting for: [received:nodes:190630dc-d4b2-459b-b866-3f8c633d43ad:localhost]

2017-11-29 09:33:20 | [Mutex] received everything.

2017-11-29 09:33:20 | [Mutex] isItemNotified: received:node:190630dc-d4b2-459b-b866-3f8c633d43ad:localhost:node-d171268e-097a-40b4-bc32-19c2a0310ef6:Node d171268e-097a-40b4-bc32-19c2a0310ef6 :: true

createSubnodes 1.013s
2017-11-29 09:33:20 |

2017-11-29 09:33:20 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:20 | ------------------------------------

2017-11-29 09:33:20 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="tAr0aB" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><create node="node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8"/><configure><x xmlns="jabber:x:data" type="submit"><field type="text-single" var="pubsub#title"><value>Node 02ebaf95-446b-4f04-a51f-55bb3fb7cea8</value></field><field type="text-single" var="pubsub#node_type"><value>collection</value></field></x></configure></pubsub></iq>

2017-11-29 09:33:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="tAr0aB" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><create node="node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8"/><configure><x xmlns="jabber:x:data" type="submit"><field type="text-single" var="pubsub#title"><value>Node 02ebaf95-446b-4f04-a51f-55bb3fb7cea8</value></field><field type="text-single" var="pubsub#node_type"><value>collection</value></field></x></configure></pubsub></iq>

2017-11-29 09:33:20 | [Mutex] waiting for: [created:node:node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8:Node 02ebaf95-446b-4f04-a51f-55bb3fb7cea8]

2017-11-29 09:33:20 | [Mutex] received everything.

2017-11-29 09:33:20 | [Mutex] isItemNotified: created:node:node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8:Node 02ebaf95-446b-4f04-a51f-55bb3fb7cea8 :: true

2017-11-29 09:33:21 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="zwd6nS" type="get"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>

2017-11-29 09:33:21 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="zwd6nS" type="get"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>

2017-11-29 09:33:21 | [Mutex] waiting for: [received:nodes:f5d603f0-c452-4fb5-9538-cfff380fd7da:localhost]

2017-11-29 09:33:21 | [Mutex] received everything.

2017-11-29 09:33:21 | [Mutex] isItemNotified: received:node:f5d603f0-c452-4fb5-9538-cfff380fd7da:localhost:node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8:Node 02ebaf95-446b-4f04-a51f-55bb3fb7cea8 :: true

deleteNodes 1.014s
2017-11-29 09:33:26 |

2017-11-29 09:33:26 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:26 | ------------------------------------

2017-11-29 09:33:26 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="6FgpOZ" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub#owner"><delete node="node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8"/></pubsub></iq>

2017-11-29 09:33:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="6FgpOZ" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub#owner"><delete node="node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8"/></pubsub></iq>

2017-11-29 09:33:26 | [Mutex] waiting for: [deleted:node:node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8]

2017-11-29 09:33:26 | [Mutex] received everything.

2017-11-29 09:33:26 | [Mutex] isItemNotified: deleted:node:node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8 :: true

2017-11-29 09:33:27 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="eyTxr1" type="get"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>

2017-11-29 09:33:27 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="eyTxr1" type="get"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>

2017-11-29 09:33:27 | [Mutex] waiting for: [received:nodes:5feb941b-3449-4501-b998-17a62496ca6b:localhost]

2017-11-29 09:33:27 | [Mutex] received everything.

2017-11-29 09:33:27 | [Mutex] isItemNotified: received:node:5feb941b-3449-4501-b998-17a62496ca6b:localhost:node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8:Node 02ebaf95-446b-4f04-a51f-55bb3fb7cea8 :: false

deleteSubnodes 1.017s
2017-11-29 09:33:24 |

2017-11-29 09:33:24 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:25 | ------------------------------------

2017-11-29 09:33:25 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="aT27s1" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub#owner"><delete node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"/></pubsub></iq>

2017-11-29 09:33:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="aT27s1" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub#owner"><delete node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"/></pubsub></iq>

2017-11-29 09:33:25 | [Mutex] waiting for: [deleted:node:node-d171268e-097a-40b4-bc32-19c2a0310ef6]

2017-11-29 09:33:25 | [Mutex] received everything.

2017-11-29 09:33:25 | [Mutex] isItemNotified: deleted:node:node-d171268e-097a-40b4-bc32-19c2a0310ef6 :: true

2017-11-29 09:33:26 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="sJwYoW" type="get"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>

2017-11-29 09:33:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="sJwYoW" type="get"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>

2017-11-29 09:33:26 | [Mutex] received everything.

2017-11-29 09:33:26 | [Mutex] isItemNotified: received:node:565a35da-a599-43ac-99b3-23c8f94af372:localhost:node-d171268e-097a-40b4-bc32-19c2a0310ef6:Node d171268e-097a-40b4-bc32-19c2a0310ef6 :: false

2017-11-29 09:33:26 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="vGlDjR" type="get"><query xmlns="http://jabber.org/protocol/disco#items" node="node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8"/></iq>

2017-11-29 09:33:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="vGlDjR" type="get"><query xmlns="http://jabber.org/protocol/disco#items" node="node-02ebaf95-446b-4f04-a51f-55bb3fb7cea8"/></iq>

2017-11-29 09:33:26 | [Mutex] waiting for: [received:nodes:5253f717-ea6d-48d7-b621-eb51b7c53719:localhost]

2017-11-29 09:33:26 | [Mutex] received everything.

2017-11-29 09:33:26 | [Mutex] isItemNotified: received:node:5253f717-ea6d-48d7-b621-eb51b7c53719:localhost:node-d171268e-097a-40b4-bc32-19c2a0310ef6:Node d171268e-097a-40b4-bc32-19c2a0310ef6 :: false

publishItemsToNodes 0.018s
2017-11-29 09:33:23 |

2017-11-29 09:33:23 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:23 | ------------------------------------

2017-11-29 09:33:23 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="nAfaOE" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><publish node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"><item id="item-ab711aad-73e1-41bd-a2d5-b68accccae80"><test>item-ab711aad-73e1-41bd-a2d5-b68accccae80</test></item></publish></pubsub></iq>

2017-11-29 09:33:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="nAfaOE" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><publish node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"><item id="item-ab711aad-73e1-41bd-a2d5-b68accccae80"><test>item-ab711aad-73e1-41bd-a2d5-b68accccae80</test></item></publish></pubsub></iq>

2017-11-29 09:33:23 | [Mutex] waiting for: [published:item:item-ab711aad-73e1-41bd-a2d5-b68accccae80:admin@localhost]

2017-11-29 09:33:23 | [Mutex] received everything.

2017-11-29 09:33:23 | [Mutex] isItemNotified: published:item:item-ab711aad-73e1-41bd-a2d5-b68accccae80:admin@localhost :: true

2017-11-29 09:33:23 | [Mutex] waiting for: [published:item:notifieditem-ab711aad-73e1-41bd-a2d5-b68accccae80:admin@localhost]

2017-11-29 09:33:23 | [Mutex] received everything.

2017-11-29 09:33:23 | [Mutex] isItemNotified: published:item:notifieditem-ab711aad-73e1-41bd-a2d5-b68accccae80:admin@localhost :: true

retractItemsFromNodes 0.046s
2017-11-29 09:33:23 |

2017-11-29 09:33:23 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:23 | ------------------------------------

2017-11-29 09:33:23 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="quTKIG" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><retract node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"><item id="item-ab711aad-73e1-41bd-a2d5-b68accccae80"/></retract></pubsub></iq>

2017-11-29 09:33:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="quTKIG" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><retract node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"><item id="item-ab711aad-73e1-41bd-a2d5-b68accccae80"/></retract></pubsub></iq>

2017-11-29 09:33:23 | [Mutex] waiting for: [retracted:item:item-ab711aad-73e1-41bd-a2d5-b68accccae80:admin@localhost]

2017-11-29 09:33:23 | [Mutex] waiting for: [retracted:item:item-ab711aad-73e1-41bd-a2d5-b68accccae80:admin@localhost]

2017-11-29 09:33:23 | [Mutex] received everything.

2017-11-29 09:33:23 | [Mutex] isItemNotified: retracted:item:item-ab711aad-73e1-41bd-a2d5-b68accccae80:admin@localhost :: true

2017-11-29 09:33:23 | [Mutex] received everything.

2017-11-29 09:33:23 | [Mutex] isItemNotified: retracted:item:notifieditem-ab711aad-73e1-41bd-a2d5-b68accccae80:admin@localhost :: true

retrieveItemsFromNodes 0.006s
2017-11-29 09:33:23 |

2017-11-29 09:33:23 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:23 | ------------------------------------

2017-11-29 09:33:23 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="sFsQ8q" type="get"><pubsub xmlns="http://jabber.org/protocol/pubsub"><items node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"><item id="item-ab711aad-73e1-41bd-a2d5-b68accccae80"/></items></pubsub></iq>

2017-11-29 09:33:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="sFsQ8q" type="get"><pubsub xmlns="http://jabber.org/protocol/pubsub"><items node="node-d171268e-097a-40b4-bc32-19c2a0310ef6"><item id="item-ab711aad-73e1-41bd-a2d5-b68accccae80"/></items></pubsub></iq>

2017-11-29 09:33:23 | [Mutex] waiting for: [retrieved:item:item-ab711aad-73e1-41bd-a2d5-b68accccae80:payload-matches:true:localhost]

2017-11-29 09:33:23 | [Mutex] received everything.

2017-11-29 09:33:23 | [Mutex] isItemNotified: retrieved:item:item-ab711aad-73e1-41bd-a2d5-b68accccae80:payload-matches:true:localhost :: true

retrieveUserSubscriptions 0.005s
2017-11-29 09:33:23 |

2017-11-29 09:33:23 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:23 | ------------------------------------

2017-11-29 09:33:23 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="fhqy9l0100"><command xmlns="http://jabber.org/protocol/commands" node="retrieve-user-subscriptions" action="execute"><x xmlns="jabber:x:data" type="submit"><field var="jid" type="jid-single"><value>admin@localhost</value></field><field var="node-pattern" type="text-single"/></x></command></iq>

2017-11-29 09:33:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="fhqy9l0100"><command xmlns="http://jabber.org/protocol/commands" node="retrieve-user-subscriptions" action="execute"><x xmlns="jabber:x:data" type="submit"><field var="jid" type="jid-single"><value>admin@localhost</value></field><field var="node-pattern" type="text-single"/></x></command></iq>

2017-11-29 09:33:23 | [Mutex] received everything.

retrieveUserSubscriptionsWithRegex 0.003s
2017-11-29 09:33:23 |

2017-11-29 09:33:23 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:23 | ------------------------------------

2017-11-29 09:33:23 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="6jok6s0101"><command xmlns="http://jabber.org/protocol/commands" node="retrieve-user-subscriptions" action="execute"><x xmlns="jabber:x:data" type="submit"><field var="jid" type="jid-single"><value>admin@localhost</value></field><field var="node-pattern" type="text-single"><value>(?!node-d171268e-097a-40b4-bc32-19c2a0310ef6)</value></field></x></command></iq>

2017-11-29 09:33:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="6jok6s0101"><command xmlns="http://jabber.org/protocol/commands" node="retrieve-user-subscriptions" action="execute"><x xmlns="jabber:x:data" type="submit"><field var="jid" type="jid-single"><value>admin@localhost</value></field><field var="node-pattern" type="text-single"><value>(?!node-d171268e-097a-40b4-bc32-19c2a0310ef6)</value></field></x></command></iq>

2017-11-29 09:33:23 | [Mutex] received everything.

subscribeNodes 1.006s
2017-11-29 09:33:22 |

2017-11-29 09:33:22 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:22 | ------------------------------------

2017-11-29 09:33:22 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="5AhmVQ" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><subscribe node="node-d171268e-097a-40b4-bc32-19c2a0310ef6" jid="admin@localhost"/></pubsub></iq>

2017-11-29 09:33:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="5AhmVQ" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><subscribe node="node-d171268e-097a-40b4-bc32-19c2a0310ef6" jid="admin@localhost"/></pubsub></iq>

2017-11-29 09:33:22 | [Mutex] waiting for: [subscribed:nodes:3e3a7aa6-f68f-4bc2-88a4-cab38cc71fc0:admin@localhost]

2017-11-29 09:33:22 | [Mutex] received everything.

2017-11-29 09:33:22 | [Mutex] isItemNotified: subscribed:nodes:3e3a7aa6-f68f-4bc2-88a4-cab38cc71fc0:admin@localhost :: true

unsubscribeNodes 1.204s
2017-11-29 09:33:23 |

2017-11-29 09:33:23 | null / [TestClass name=class tigase.tests.pubsub.TestPubSub]

2017-11-29 09:33:23 | ------------------------------------

2017-11-29 09:33:23 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq to="pubsub.localhost" id="SwXKus" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><unsubscribe node="node-d171268e-097a-40b4-bc32-19c2a0310ef6" jid="admin@localhost"/></pubsub></iq>

2017-11-29 09:33:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1825923873): <iq to="pubsub.localhost" id="SwXKus" type="set"><pubsub xmlns="http://jabber.org/protocol/pubsub"><unsubscribe node="node-d171268e-097a-40b4-bc32-19c2a0310ef6" jid="admin@localhost"/></pubsub></iq>

2017-11-29 09:33:23 | [Mutex] waiting for: [unsubscribed:nodes:195f9403-c569-43bb-bcad-1c94756bf4fc:admin@localhost]

2017-11-29 09:33:23 | [Mutex] received everything.

2017-11-29 09:33:23 | [Mutex] isItemNotified: unsubscribed:nodes:195f9403-c569-43bb-bcad-1c94756bf4fc:admin@localhost :: true