=== Test case: pubsub_SUITE:notify_collection_test/1 (click for source code) === Config value: [{watchdog,<0.918.2>}, {mim_data_dir,"/home/circleci/project/big_tests/tests/pubsub_SUITE_data"}, {preset,"odbc_mssql_mnesia"}, {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@ebe8a8f9fc53.2022-01-25_16.21.59/big_tests.tests.pubsub_SUITE.logs/run.2022-01-25_16.32.35/pubsub_suite.notify_collection_test.html"}, {tc_group_properties,[{name,'dag+collection'}, {repeat_until_all_ok,3}, sequence]}, {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@ebe8a8f9fc53.2022-01-25_16.21.59/big_tests.tests.pubsub_SUITE.logs/run.2022-01-25_16.32.35/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 => [{backend,rdbms}], mod_sic => [],mod_stream_management => [], mod_vcard => [{backend,rdbms},{host,{prefix,<<"vjud.">>}}]}}] === Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@ebe8a8f9fc53.2022-01-25_16.21.59" === Started at 2022-01-25 16:32:45
*** User 2022-01-25 16:32:45.801 *** alicE_notify_collection_test_1988@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-25 16:32:45.801 *** alicE_notify_collection_test_1988@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='9c1b63671a95a721' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:32:45.802 *** alicE_notify_collection_test_1988@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-25 16:32:45.802 *** alicE_notify_collection_test_1988@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX25vdGlmeV9jb2xsZWN0aW9uX3Rlc3RfMTk4OABtYXR5Z3J5c2E=</auth>
*** User 2022-01-25 16:32:45.803 *** alicE_notify_collection_test_1988@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:32:45.803 *** alicE_notify_collection_test_1988@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-25 16:32:45.803 *** alicE_notify_collection_test_1988@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d93c92fc7578c562' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:32:45.804 *** alicE_notify_collection_test_1988@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-25 16:32:45.804 *** alicE_notify_collection_test_1988@localhost/res1 out <iq type='set' id='bbbd211890f29d495aceea6838c9c062'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-25 16:32:45.804 *** alicE_notify_collection_test_1988@localhost/res1 in <iq id='bbbd211890f29d495aceea6838c9c062' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alicE_notify_collection_test_1988@localhost/res1</jid> </bind> </iq>
*** User 2022-01-25 16:32:45.804 *** alicE_notify_collection_test_1988@localhost/res1 out <iq type='set' id='bb1b0a0ecf777606badb624a3402b557'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:32:45.804 *** alicE_notify_collection_test_1988@localhost/res1 in <iq type='result' id='bb1b0a0ecf777606badb624a3402b557'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:32:45.805 *** alicE_notify_collection_test_1988@localhost/res1 out <presence/>
*** User 2022-01-25 16:32:45.806 *** alicE_notify_collection_test_1988@localhost/res1 in <presence from='alicE_notify_collection_test_1988@localhost/res1' to='alice_notify_collection_test_1988@localhost/res1' xml:lang='en'/>
*** User 2022-01-25 16:32:45.807 *** bOb_notify_collection_test_1988@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-25 16:32:45.807 *** bOb_notify_collection_test_1988@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='6fc6f8f099fea70e' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:32:45.807 *** bOb_notify_collection_test_1988@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-25 16:32:45.807 *** bOb_notify_collection_test_1988@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9ub3RpZnlfY29sbGVjdGlvbl90ZXN0XzE5ODgAbWFrcm9saWth</auth>
*** User 2022-01-25 16:32:45.808 *** bOb_notify_collection_test_1988@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:32:45.808 *** bOb_notify_collection_test_1988@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-25 16:32:45.809 *** bOb_notify_collection_test_1988@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='24630659d26c853d' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:32:45.809 *** bOb_notify_collection_test_1988@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-25 16:32:45.809 *** bOb_notify_collection_test_1988@localhost/res1 out <iq type='set' id='b94fc2a615e546e1e6bf846185df0dba'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-25 16:32:45.809 *** bOb_notify_collection_test_1988@localhost/res1 in <iq id='b94fc2a615e546e1e6bf846185df0dba' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>bOb_notify_collection_test_1988@localhost/res1</jid> </bind> </iq>
*** User 2022-01-25 16:32:45.809 *** bOb_notify_collection_test_1988@localhost/res1 out <iq type='set' id='adbc3b5f47979c80cef8a73c041ff719'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:32:45.810 *** bOb_notify_collection_test_1988@localhost/res1 in <iq type='result' id='adbc3b5f47979c80cef8a73c041ff719'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:32:45.810 *** bOb_notify_collection_test_1988@localhost/res1 out <presence/>
*** User 2022-01-25 16:32:45.811 *** bOb_notify_collection_test_1988@localhost/res1 in <presence from='bOb_notify_collection_test_1988@localhost/res1' to='bob_notify_collection_test_1988@localhost/res1' xml:lang='en'/>
*** User 2022-01-25 16:32:45.811 *** alicE_notify_collection_test_1988@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_collection_test_1988-pubsub.localhost-princely_musings_cC3KclJBIb0=-create_node' from='alicE_notify_collection_test_1988@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='princely_musings_cC3KclJBIb0='/> <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#node_type'> <value>collection</value> </field> </x> </configure> </pubsub> </iq>
*** User 2022-01-25 16:32:45.816 *** alicE_notify_collection_test_1988@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_collection_test_1988@localhost/res1' id='alicE_notify_collection_test_1988-pubsub.localhost-princely_musings_cC3KclJBIb0=-create_node' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='princely_musings_cC3KclJBIb0='/> </pubsub> </iq>
*** User 2022-01-25 16:32:45.816 *** alicE_notify_collection_test_1988@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_mW2G50USF3c=-create_node' from='alicE_notify_collection_test_1988@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='leaf_mW2G50USF3c='/> <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#collection'> <value>princely_musings_cC3KclJBIb0=</value> </field> </x> </configure> </pubsub> </iq>
*** User 2022-01-25 16:32:45.822 *** alicE_notify_collection_test_1988@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_collection_test_1988@localhost/res1' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_mW2G50USF3c=-create_node' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='leaf_mW2G50USF3c='/> </pubsub> </iq>
*** User 2022-01-25 16:32:45.822 *** alicE_notify_collection_test_1988@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_yn6DQB+EMgo=-create_node' from='alicE_notify_collection_test_1988@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='leaf_yn6DQB+EMgo='/> <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#collection'> <value>princely_musings_cC3KclJBIb0=</value> </field> </x> </configure> </pubsub> </iq>
*** User 2022-01-25 16:32:45.890 *** alicE_notify_collection_test_1988@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_collection_test_1988@localhost/res1' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_yn6DQB+EMgo=-create_node' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='leaf_yn6DQB+EMgo='/> </pubsub> </iq>
*** User 2022-01-25 16:32:45.890 *** bOb_notify_collection_test_1988@localhost/res1 out <iq to='pubsub.localhost' type='set' id='bOb_notify_collection_test_1988-pubsub.localhost-princely_musings_cC3KclJBIb0=-subscribe' from='bOb_notify_collection_test_1988@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <subscribe node='princely_musings_cC3KclJBIb0=' jid='bOb_notify_collection_test_1988@localhost/res1'/> </pubsub> </iq>
*** User 2022-01-25 16:32:45.893 *** bOb_notify_collection_test_1988@localhost/res1 in <iq from='pubsub.localhost' to='bOb_notify_collection_test_1988@localhost/res1' id='bOb_notify_collection_test_1988-pubsub.localhost-princely_musings_cC3KclJBIb0=-subscribe' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <subscription jid='bob_notify_collection_test_1988@localhost/res1' subscription='subscribed' subid='1643-128365-892308' node='princely_musings_cC3KclJBIb0='/> </pubsub> </iq>
*** User 2022-01-25 16:32:45.893 *** alicE_notify_collection_test_1988@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_mW2G50USF3c=-publish' from='alicE_notify_collection_test_1988@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <publish node='leaf_mW2G50USF3c='> <item id='item1'> <entry xmlns='http://www.w3.org/2005/Atom'/> </item> </publish> </pubsub> </iq>
*** User 2022-01-25 16:32:46.487 *** alicE_notify_collection_test_1988@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_collection_test_1988@localhost/res1' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_mW2G50USF3c=-publish' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <publish node='leaf_mW2G50USF3c='> <item id='item1'/> </publish> </pubsub> </iq>
*** User 2022-01-25 16:32:46.487 *** bOb_notify_collection_test_1988@localhost/res1 in <message from='pubsub.localhost' to='bob_notify_collection_test_1988@localhost/res1' type='headline'> <event xmlns='http://jabber.org/protocol/pubsub#event'> <items node='leaf_mW2G50USF3c='> <item id='item1'> <entry xmlns='http://www.w3.org/2005/Atom'/> </item> </items> </event> <headers xmlns='http://jabber.org/protocol/shim'> <header name='Collection'>princely_musings_cC3KclJBIb0=</header> </headers> </message>
*** User 2022-01-25 16:32:46.487 *** alicE_notify_collection_test_1988@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_yn6DQB+EMgo=-publish' from='alicE_notify_collection_test_1988@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <publish node='leaf_yn6DQB+EMgo='> <item id='item2'> <entry xmlns='http://www.w3.org/2005/Atom'/> </item> </publish> </pubsub> </iq>
*** User 2022-01-25 16:32:46.777 *** alicE_notify_collection_test_1988@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_collection_test_1988@localhost/res1' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_yn6DQB+EMgo=-publish' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <publish node='leaf_yn6DQB+EMgo='> <item id='item2'/> </publish> </pubsub> </iq>
*** User 2022-01-25 16:32:46.777 *** bOb_notify_collection_test_1988@localhost/res1 in <message from='pubsub.localhost' to='bob_notify_collection_test_1988@localhost/res1' type='headline'> <event xmlns='http://jabber.org/protocol/pubsub#event'> <items node='leaf_yn6DQB+EMgo='> <item id='item2'> <entry xmlns='http://www.w3.org/2005/Atom'/> </item> </items> </event> <headers xmlns='http://jabber.org/protocol/shim'> <header name='Collection'>princely_musings_cC3KclJBIb0=</header> </headers> </message>
*** User 2022-01-25 16:32:46.777 *** alicE_notify_collection_test_1988@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_mW2G50USF3c=-delete_node' from='alicE_notify_collection_test_1988@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub#owner'> <delete node='leaf_mW2G50USF3c='/> </pubsub> </iq>
*** User 2022-01-25 16:32:47.135 *** alicE_notify_collection_test_1988@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_collection_test_1988@localhost/res1' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_mW2G50USF3c=-delete_node' type='result'/>
*** User 2022-01-25 16:32:47.135 *** alicE_notify_collection_test_1988@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_yn6DQB+EMgo=-delete_node' from='alicE_notify_collection_test_1988@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub#owner'> <delete node='leaf_yn6DQB+EMgo='/> </pubsub> </iq>
*** User 2022-01-25 16:32:47.419 *** alicE_notify_collection_test_1988@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_collection_test_1988@localhost/res1' id='alicE_notify_collection_test_1988-pubsub.localhost-leaf_yn6DQB+EMgo=-delete_node' type='result'/>
*** User 2022-01-25 16:32:47.419 *** alicE_notify_collection_test_1988@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_collection_test_1988-pubsub.localhost-princely_musings_cC3KclJBIb0=-delete_node' from='alicE_notify_collection_test_1988@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub#owner'> <delete node='princely_musings_cC3KclJBIb0='/> </pubsub> </iq>
*** User 2022-01-25 16:32:47.698 *** alicE_notify_collection_test_1988@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_collection_test_1988@localhost/res1' id='alicE_notify_collection_test_1988-pubsub.localhost-princely_musings_cC3KclJBIb0=-delete_node' type='result'/>
*** User 2022-01-25 16:32:47.698 *** bOb_notify_collection_test_1988@localhost/res1 out </stream:stream>
*** User 2022-01-25 16:32:47.698 *** bOb_notify_collection_test_1988@localhost/res1 in </stream:stream>
*** User 2022-01-25 16:32:47.698 *** alicE_notify_collection_test_1988@localhost/res1 out </stream:stream>
*** User 2022-01-25 16:32:47.988 *** alicE_notify_collection_test_1988@localhost/res1 in </stream:stream>
=== Ended at 2022-01-25 16:32:48 === successfully completed test case === === Returned value: ok
Test run history | Top level test index | Latest test result