=== Test case: pubsub_SUITE:notify_test/1 (click for source code)
=== Config value:
[{watchdog,<0.8174.1>},
{mim_data_dir,"/home/circleci/project/big_tests/tests/pubsub_SUITE_data"},
{preset,"internal_mnesia"},
{tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@34a9b6d2516c.2022-01-27_15.25.07/big_tests.tests.pubsub_SUITE.logs/run.2022-01-27_15.34.03/pubsub_suite.notify_test.17412.html"},
{tc_group_properties,[{name,'tree+basic'},
{repeat_until_all_ok,3},
parallel]},
{tc_group_path,[]},
{data_dir,"/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/pubsub_SUITE_data/"},
{priv_dir,"/home/circleci/project/big_tests/ct_report/ct_run.test@34a9b6d2516c.2022-01-27_15.25.07/big_tests.tests.pubsub_SUITE.logs/run.2022-01-27_15.34.03/log_private/"},
{{saved_modules,mongooseim@localhost,<<"localhost">>},
#{mod_adhoc => [],mod_amp => [],mod_bosh => [],
mod_cache_users => [{number_of_segments,5},{time_to_live,2}],
mod_carboncopy => [],mod_commands => [],
mod_disco => [{users_can_see_hidden_services,false}],
mod_muc_commands => [],mod_muc_light_commands => [],
mod_register =>
[{access,register},
{ip_access,[{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]},
{welcome_message,{[],[]}}],
mod_roster => [],mod_sic => [],mod_stream_management => [],
mod_vcard => [{host,{prefix,<<"vjud.">>}}]}}]
=== Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@34a9b6d2516c.2022-01-27_15.25.07"
=== Started at 2022-01-27 15:34:35
*** User 2022-01-27 15:34:35.260 ***
alicE_notify_test_1165@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 15:34:35.261 ***
alicE_notify_test_1165@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a5bc796dbed1d33b' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:34:35.262 ***
alicE_notify_test_1165@localhost/res1 in
<stream:features>
<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
<mechanism>SCRAM-SHA-256</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 15:34:35.262 ***
alicE_notify_test_1165@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX25vdGlmeV90ZXN0XzExNjUAbWF0eWdyeXNh</auth>
*** User 2022-01-27 15:34:35.262 ***
alicE_notify_test_1165@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:34:35.263 ***
alicE_notify_test_1165@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 15:34:35.263 ***
alicE_notify_test_1165@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='941f9f7986aeef88' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:34:35.263 ***
alicE_notify_test_1165@localhost/res1 in
<stream:features>
<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'/>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 15:34:35.263 ***
alicE_notify_test_1165@localhost/res1 out
<iq type='set' id='0ae9cb9e832b154ca0eaf151c180b6e4'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 15:34:35.265 ***
alicE_notify_test_1165@localhost/res1 in
<iq id='0ae9cb9e832b154ca0eaf151c180b6e4' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>alicE_notify_test_1165@localhost/res1</jid>
</bind>
</iq>
*** User 2022-01-27 15:34:35.265 ***
alicE_notify_test_1165@localhost/res1 out
<iq type='set' id='a5b0705132bdc97e571479a9398f5235'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:34:35.266 ***
alicE_notify_test_1165@localhost/res1 in
<iq type='result' id='a5b0705132bdc97e571479a9398f5235'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:34:35.266 ***
alicE_notify_test_1165@localhost/res1 out
<presence/>
*** User 2022-01-27 15:34:35.267 ***
alicE_notify_test_1165@localhost/res1 in
<presence from='alicE_notify_test_1165@localhost/res1' to='alice_notify_test_1165@localhost/res1' xml:lang='en'/>
*** User 2022-01-27 15:34:35.306 ***
bOb_notify_test_1165@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 15:34:35.308 ***
bOb_notify_test_1165@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='f67b36641b0af89e' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:34:35.308 ***
bOb_notify_test_1165@localhost/res1 in
<stream:features>
<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
<mechanism>SCRAM-SHA-256</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 15:34:35.308 ***
bOb_notify_test_1165@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9ub3RpZnlfdGVzdF8xMTY1AG1ha3JvbGlrYQ==</auth>
*** User 2022-01-27 15:34:35.309 ***
bOb_notify_test_1165@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:34:35.309 ***
bOb_notify_test_1165@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 15:34:35.310 ***
bOb_notify_test_1165@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3e71961eb31acc06' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:34:35.310 ***
bOb_notify_test_1165@localhost/res1 in
<stream:features>
<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'/>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 15:34:35.310 ***
bOb_notify_test_1165@localhost/res1 out
<iq type='set' id='29823b54bb81555a85c448c06645a3ab'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 15:34:35.312 ***
bOb_notify_test_1165@localhost/res1 in
<iq id='29823b54bb81555a85c448c06645a3ab' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>bOb_notify_test_1165@localhost/res1</jid>
</bind>
</iq>
*** User 2022-01-27 15:34:35.312 ***
bOb_notify_test_1165@localhost/res1 out
<iq type='set' id='d635b5e6820fc1ef3576b5b6f9be8cb6'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:34:35.312 ***
bOb_notify_test_1165@localhost/res1 in
<iq type='result' id='d635b5e6820fc1ef3576b5b6f9be8cb6'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:34:35.313 ***
bOb_notify_test_1165@localhost/res1 out
<presence/>
*** User 2022-01-27 15:34:35.314 ***
bOb_notify_test_1165@localhost/res1 in
<presence from='bOb_notify_test_1165@localhost/res1' to='bob_notify_test_1165@localhost/res1' xml:lang='en'/>
*** User 2022-01-27 15:34:35.315 ***
bOb_notify_test_1165@localhost/res2 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 15:34:35.317 ***
bOb_notify_test_1165@localhost/res2 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='502dc2a6aab9e7b5' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:34:35.317 ***
bOb_notify_test_1165@localhost/res2 in
<stream:features>
<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
<mechanism>SCRAM-SHA-256</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 15:34:35.317 ***
bOb_notify_test_1165@localhost/res2 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9ub3RpZnlfdGVzdF8xMTY1AG1ha3JvbGlrYQ==</auth>
*** User 2022-01-27 15:34:35.318 ***
bOb_notify_test_1165@localhost/res2 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:34:35.318 ***
bOb_notify_test_1165@localhost/res2 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 15:34:35.318 ***
bOb_notify_test_1165@localhost/res2 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='42bfc190d73cd7b3' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:34:35.318 ***
bOb_notify_test_1165@localhost/res2 in
<stream:features>
<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'/>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 15:34:35.318 ***
bOb_notify_test_1165@localhost/res2 out
<iq type='set' id='fa928275776bf67aa5a30c352a620e91'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res2</resource>
</bind>
</iq>
*** User 2022-01-27 15:34:35.319 ***
bOb_notify_test_1165@localhost/res2 in
<iq id='fa928275776bf67aa5a30c352a620e91' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>bOb_notify_test_1165@localhost/res2</jid>
</bind>
</iq>
*** User 2022-01-27 15:34:35.319 ***
bOb_notify_test_1165@localhost/res2 out
<iq type='set' id='58f3d86cc39f3780d420ce1c0fbf1909'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:34:35.319 ***
bOb_notify_test_1165@localhost/res2 in
<iq type='result' id='58f3d86cc39f3780d420ce1c0fbf1909'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:34:35.319 ***
bOb_notify_test_1165@localhost/res2 out
<presence/>
*** User 2022-01-27 15:34:35.320 ***
bOb_notify_test_1165@localhost/res2 in
<presence from='bOb_notify_test_1165@localhost/res2' to='bob_notify_test_1165@localhost/res2' xml:lang='en'/>
*** User 2022-01-27 15:34:35.320 ***
bOb_notify_test_1165@localhost/res2 in
<presence from='bob_notify_test_1165@localhost/res1' to='bOb_notify_test_1165@localhost/res2' xml:lang='en'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T15:34:35Z' from='bob_notify_test_1165@localhost/res1'/>
</presence>
*** User 2022-01-27 15:34:35.320 ***
bOb_notify_test_1165@localhost/res1 in
<presence from='bOb_notify_test_1165@localhost/res2' to='bob_notify_test_1165@localhost/res1' xml:lang='en'/>
*** User 2022-01-27 15:34:35.321 ***
geralt_notify_test_1165@localhost/res1 out
<open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-01-27 15:34:35.322 ***
geralt_notify_test_1165@localhost/res1 in
<open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='5db865b1fc508d5e' from='localhost'/>
*** User 2022-01-27 15:34:35.322 ***
geralt_notify_test_1165@localhost/res1 in
<features xmlns='http://etherx.jabber.org/streams'>
<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
<mechanism>SCRAM-SHA-256</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</features>
*** User 2022-01-27 15:34:35.322 ***
geralt_notify_test_1165@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGdlcmFsdF9ub3RpZnlfdGVzdF8xMTY1AHdpdGNoZXI=</auth>
*** User 2022-01-27 15:34:35.323 ***
geralt_notify_test_1165@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:34:35.323 ***
geralt_notify_test_1165@localhost/res1 out
<open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-01-27 15:34:35.323 ***
geralt_notify_test_1165@localhost/res1 in
<open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='ae18cedb479ed594' from='localhost'/>
*** User 2022-01-27 15:34:35.323 ***
geralt_notify_test_1165@localhost/res1 in
<features xmlns='http://etherx.jabber.org/streams'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</features>
*** User 2022-01-27 15:34:35.323 ***
geralt_notify_test_1165@localhost/res1 out
<iq type='set' id='89904ce4a541be43e7dd0bff7a340bb1'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 15:34:35.323 ***
geralt_notify_test_1165@localhost/res1 in
<iq id='89904ce4a541be43e7dd0bff7a340bb1' type='result' xmlns='jabber:client'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>geralt_notify_test_1165@localhost/res1</jid>
</bind>
</iq>
*** User 2022-01-27 15:34:35.323 ***
geralt_notify_test_1165@localhost/res1 out
<iq type='set' id='8a6fe63b0f5dc1442aa98431d153474d'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:34:35.324 ***
geralt_notify_test_1165@localhost/res1 in
<iq type='result' id='8a6fe63b0f5dc1442aa98431d153474d' xmlns='jabber:client'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:34:35.324 ***
geralt_notify_test_1165@localhost/res1 out
<presence/>
*** User 2022-01-27 15:34:35.325 ***
geralt_notify_test_1165@localhost/res1 in
<presence from='geralt_notify_test_1165@localhost/res1' to='geralt_notify_test_1165@localhost/res1' xmlns='jabber:client'/>
*** User 2022-01-27 15:34:35.326 ***
geralt_notify_test_1165@localhost/res2 out
<open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-01-27 15:34:35.326 ***
geralt_notify_test_1165@localhost/res2 in
<open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='91eab8a81eb8af53' from='localhost'/>
*** User 2022-01-27 15:34:35.326 ***
geralt_notify_test_1165@localhost/res2 in
<features xmlns='http://etherx.jabber.org/streams'>
<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
<mechanism>SCRAM-SHA-256</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</features>
*** User 2022-01-27 15:34:35.326 ***
geralt_notify_test_1165@localhost/res2 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGdlcmFsdF9ub3RpZnlfdGVzdF8xMTY1AHdpdGNoZXI=</auth>
*** User 2022-01-27 15:34:35.327 ***
geralt_notify_test_1165@localhost/res2 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:34:35.327 ***
geralt_notify_test_1165@localhost/res2 out
<open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-01-27 15:34:35.327 ***
geralt_notify_test_1165@localhost/res2 in
<open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='6d433f8a0ae4dcb4' from='localhost'/>
*** User 2022-01-27 15:34:35.327 ***
geralt_notify_test_1165@localhost/res2 in
<features xmlns='http://etherx.jabber.org/streams'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</features>
*** User 2022-01-27 15:34:35.327 ***
geralt_notify_test_1165@localhost/res2 out
<iq type='set' id='27364f88ef13a34747b6de89f89670ba'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res2</resource>
</bind>
</iq>
*** User 2022-01-27 15:34:35.328 ***
geralt_notify_test_1165@localhost/res2 in
<iq id='27364f88ef13a34747b6de89f89670ba' type='result' xmlns='jabber:client'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>geralt_notify_test_1165@localhost/res2</jid>
</bind>
</iq>
*** User 2022-01-27 15:34:35.328 ***
geralt_notify_test_1165@localhost/res2 out
<iq type='set' id='7b45a7493675c40efa0ded772f2cda91'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:34:35.328 ***
geralt_notify_test_1165@localhost/res2 in
<iq type='result' id='7b45a7493675c40efa0ded772f2cda91' xmlns='jabber:client'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:34:35.328 ***
geralt_notify_test_1165@localhost/res2 out
<presence/>
*** User 2022-01-27 15:34:35.329 ***
geralt_notify_test_1165@localhost/res2 in
<presence from='geralt_notify_test_1165@localhost/res2' to='geralt_notify_test_1165@localhost/res2' xmlns='jabber:client'/>
*** User 2022-01-27 15:34:35.329 ***
geralt_notify_test_1165@localhost/res2 in
<presence from='geralt_notify_test_1165@localhost/res1' to='geralt_notify_test_1165@localhost/res2' xmlns='jabber:client'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T15:34:35Z' from='geralt_notify_test_1165@localhost/res1'/>
</presence>
*** User 2022-01-27 15:34:35.329 ***
geralt_notify_test_1165@localhost/res1 in
<presence from='geralt_notify_test_1165@localhost/res2' to='geralt_notify_test_1165@localhost/res1' xmlns='jabber:client'/>
*** User 2022-01-27 15:34:35.329 ***
alicE_notify_test_1165@localhost/res1 out
<iq to='pubsub.localhost' type='set' id='alicE_notify_test_1165-pubsub.localhost-princely_musings_0HO9ttg2Zeg=-create_node' from='alicE_notify_test_1165@localhost/res1'>
<pubsub xmlns='http://jabber.org/protocol/pubsub'>
<create node='princely_musings_0HO9ttg2Zeg='/>
<configure>
<x xmlns='jabber:x:data' type='submit'>
<field var='FORM_TYPE' type='hidden'>
<value>http://jabber.org/protocol/pubsub#node_config</value>
</field>
<field var='pubsub#presence_based_delivery'>
<value>1</value>
</field>
</x>
</configure>
</pubsub>
</iq>
*** User 2022-01-27 15:34:35.330 ***
alicE_notify_test_1165@localhost/res1 in
<iq from='pubsub.localhost' to='alicE_notify_test_1165@localhost/res1' id='alicE_notify_test_1165-pubsub.localhost-princely_musings_0HO9ttg2Zeg=-create_node' type='result'>
<pubsub xmlns='http://jabber.org/protocol/pubsub'>
<create node='princely_musings_0HO9ttg2Zeg='/>
</pubsub>
</iq>
*** User 2022-01-27 15:34:35.330 ***
bOb_notify_test_1165@localhost/res1 out
<iq to='pubsub.localhost' type='set' id='bOb_notify_test_1165-pubsub.localhost-princely_musings_0HO9ttg2Zeg=-subscribe' from='bOb_notify_test_1165@localhost/res1'>
<pubsub xmlns='http://jabber.org/protocol/pubsub'>
<subscribe node='princely_musings_0HO9ttg2Zeg=' jid='bOb_notify_test_1165@localhost/res1'/>
</pubsub>
</iq>
*** User 2022-01-27 15:34:35.332 ***
bOb_notify_test_1165@localhost/res1 in
<iq from='pubsub.localhost' to='bOb_notify_test_1165@localhost/res1' id='bOb_notify_test_1165-pubsub.localhost-princely_musings_0HO9ttg2Zeg=-subscribe' type='result'>
<pubsub xmlns='http://jabber.org/protocol/pubsub'>
<subscription jid='bob_notify_test_1165@localhost/res1' subscription='subscribed' subid='1643-297675-331125' node='princely_musings_0HO9ttg2Zeg='/>
</pubsub>
</iq>
*** User 2022-01-27 15:34:35.332 ***
geralt_notify_test_1165@localhost/res1 out
<iq to='pubsub.localhost' type='set' id='geralt_notify_test_1165-pubsub.localhost-princely_musings_0HO9ttg2Zeg=-subscribe' from='geralt_notify_test_1165@localhost'>
<pubsub xmlns='http://jabber.org/protocol/pubsub'>
<subscribe node='princely_musings_0HO9ttg2Zeg=' jid='geralt_notify_test_1165@localhost'/>
</pubsub>
</iq>
*** User 2022-01-27 15:34:35.333 ***
geralt_notify_test_1165@localhost/res1 in
<iq from='pubsub.localhost' to='geralt_notify_test_1165@localhost/res1' id='geralt_notify_test_1165-pubsub.localhost-princely_musings_0HO9ttg2Zeg=-subscribe' type='result' xmlns='jabber:client'>
<pubsub xmlns='http://jabber.org/protocol/pubsub'>
<subscription jid='geralt_notify_test_1165@localhost' subscription='subscribed' subid='1643-297675-332809' node='princely_musings_0HO9ttg2Zeg='/>
</pubsub>
</iq>
*** User 2022-01-27 15:34:35.333 ***
alicE_notify_test_1165@localhost/res1 out
<iq to='pubsub.localhost' type='set' id='alicE_notify_test_1165-pubsub.localhost-princely_musings_0HO9ttg2Zeg=-publish' from='alicE_notify_test_1165@localhost/res1'>
<pubsub xmlns='http://jabber.org/protocol/pubsub'>
<publish node='princely_musings_0HO9ttg2Zeg='>
<item id='item1'>
<entry xmlns='http://www.w3.org/2005/Atom'/>
</item>
</publish>
</pubsub>
</iq>
*** User 2022-01-27 15:34:35.333 ***
alicE_notify_test_1165@localhost/res1 in
<iq from='pubsub.localhost' to='alicE_notify_test_1165@localhost/res1' id='alicE_notify_test_1165-pubsub.localhost-princely_musings_0HO9ttg2Zeg=-publish' type='result'>
<pubsub xmlns='http://jabber.org/protocol/pubsub'>
<publish node='princely_musings_0HO9ttg2Zeg='>
<item id='item1'/>
</publish>
</pubsub>
</iq>
*** User 2022-01-27 15:34:35.334 ***
bOb_notify_test_1165@localhost/res1 in
<message from='pubsub.localhost' to='bob_notify_test_1165@localhost/res1' type='headline'>
<event xmlns='http://jabber.org/protocol/pubsub#event'>
<items node='princely_musings_0HO9ttg2Zeg='>
<item id='item1'>
<entry xmlns='http://www.w3.org/2005/Atom'/>
</item>
</items>
</event>
<headers xmlns='http://jabber.org/protocol/shim'/>
</message>
*** User 2022-01-27 15:34:35.334 ***
geralt_notify_test_1165@localhost/res1 in
<message from='pubsub.localhost' to='geralt_notify_test_1165@localhost' type='headline' xmlns='jabber:client'>
<event xmlns='http://jabber.org/protocol/pubsub#event'>
<items node='princely_musings_0HO9ttg2Zeg='>
<item id='item1'>
<entry xmlns='http://www.w3.org/2005/Atom'/>
</item>
</items>
</event>
<headers xmlns='http://jabber.org/protocol/shim'/>
</message>
*** User 2022-01-27 15:34:35.334 ***
geralt_notify_test_1165@localhost/res2 in
<message from='pubsub.localhost' to='geralt_notify_test_1165@localhost' type='headline' xmlns='jabber:client'>
<event xmlns='http://jabber.org/protocol/pubsub#event'>
<items node='princely_musings_0HO9ttg2Zeg='>
<item id='item1'>
<entry xmlns='http://www.w3.org/2005/Atom'/>
</item>
</items>
</event>
<headers xmlns='http://jabber.org/protocol/shim'/>
</message>
*** User 2022-01-27 15:34:35.334 ***
alicE_notify_test_1165@localhost/res1 out
<iq to='pubsub.localhost' type='set' id='alicE_notify_test_1165-pubsub.localhost-princely_musings_0HO9ttg2Zeg=-delete_node' from='alicE_notify_test_1165@localhost/res1'>
<pubsub xmlns='http://jabber.org/protocol/pubsub#owner'>
<delete node='princely_musings_0HO9ttg2Zeg='/>
</pubsub>
</iq>
*** User 2022-01-27 15:34:35.335 ***
alicE_notify_test_1165@localhost/res1 in
<iq from='pubsub.localhost' to='alicE_notify_test_1165@localhost/res1' id='alicE_notify_test_1165-pubsub.localhost-princely_musings_0HO9ttg2Zeg=-delete_node' type='result'/>
*** User 2022-01-27 15:34:35.335 ***
geralt_notify_test_1165@localhost/res2 out
<close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-01-27 15:34:35.335 ***
geralt_notify_test_1165@localhost/res2 in
<close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-01-27 15:34:35.335 ***
geralt_notify_test_1165@localhost/res1 out
<close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-01-27 15:34:35.336 ***
geralt_notify_test_1165@localhost/res1 in
<close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-01-27 15:34:35.336 ***
bOb_notify_test_1165@localhost/res2 out
</stream:stream>
*** User 2022-01-27 15:34:35.336 ***
bOb_notify_test_1165@localhost/res2 in
</stream:stream>
*** User 2022-01-27 15:34:35.336 ***
bOb_notify_test_1165@localhost/res1 out
</stream:stream>
*** User 2022-01-27 15:34:35.336 ***
bOb_notify_test_1165@localhost/res1 in
</stream:stream>
*** User 2022-01-27 15:34:35.336 ***
alicE_notify_test_1165@localhost/res1 out
</stream:stream>
*** User 2022-01-27 15:34:35.486 ***
alicE_notify_test_1165@localhost/res1 in
</stream:stream>
=== Ended at 2022-01-27 15:34:35
=== successfully completed test case
=== === Returned value: ok