=== Test case: pubsub_SUITE:notify_nested_collections_test/1 (click for source code) === Config value: [{watchdog,<0.7661.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_nested_collections_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@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:23
*** User 2022-01-27 15:34:23.067 *** alicE_notify_nested_collections_test_1138@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:23.068 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='71e0a2b3e289638b' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:34:23.068 *** alicE_notify_nested_collections_test_1138@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:23.068 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX25vdGlmeV9uZXN0ZWRfY29sbGVjdGlvbnNfdGVzdF8xMTM4AG1hdHlncnlzYQ==</auth>
*** User 2022-01-27 15:34:23.069 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:34:23.069 *** alicE_notify_nested_collections_test_1138@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:23.069 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='48b215279155089f' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:34:23.069 *** alicE_notify_nested_collections_test_1138@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:23.069 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <iq type='set' id='2cdb6e65ef3be943ec10acb3ac6d7a81'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-27 15:34:23.069 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <iq id='2cdb6e65ef3be943ec10acb3ac6d7a81' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alicE_notify_nested_collections_test_1138@localhost/res1</jid> </bind> </iq>
*** User 2022-01-27 15:34:23.069 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <iq type='set' id='771544db11028c93b19a9d447861ae97'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:34:23.069 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <iq type='result' id='771544db11028c93b19a9d447861ae97'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:34:23.070 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <presence/>
*** User 2022-01-27 15:34:23.070 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <presence from='alicE_notify_nested_collections_test_1138@localhost/res1' to='alice_notify_nested_collections_test_1138@localhost/res1' xml:lang='en'/>
*** User 2022-01-27 15:34:23.071 *** bOb_notify_nested_collections_test_1138@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:23.071 *** bOb_notify_nested_collections_test_1138@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='dd7c87b4c687dd54' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:34:23.071 *** bOb_notify_nested_collections_test_1138@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:23.071 *** bOb_notify_nested_collections_test_1138@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9ub3RpZnlfbmVzdGVkX2NvbGxlY3Rpb25zX3Rlc3RfMTEzOABtYWtyb2xpa2E=</auth>
*** User 2022-01-27 15:34:23.072 *** bOb_notify_nested_collections_test_1138@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:34:23.072 *** bOb_notify_nested_collections_test_1138@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:23.072 *** bOb_notify_nested_collections_test_1138@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='702abebe68510b18' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:34:23.072 *** bOb_notify_nested_collections_test_1138@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:23.072 *** bOb_notify_nested_collections_test_1138@localhost/res1 out <iq type='set' id='18cb0fc4de0074f004c2677c0fe30e96'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-27 15:34:23.072 *** bOb_notify_nested_collections_test_1138@localhost/res1 in <iq id='18cb0fc4de0074f004c2677c0fe30e96' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>bOb_notify_nested_collections_test_1138@localhost/res1</jid> </bind> </iq>
*** User 2022-01-27 15:34:23.072 *** bOb_notify_nested_collections_test_1138@localhost/res1 out <iq type='set' id='07ee5049994049d9978ae9e8a2d07d46'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:34:23.072 *** bOb_notify_nested_collections_test_1138@localhost/res1 in <iq type='result' id='07ee5049994049d9978ae9e8a2d07d46'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:34:23.073 *** bOb_notify_nested_collections_test_1138@localhost/res1 out <presence/>
*** User 2022-01-27 15:34:23.073 *** bOb_notify_nested_collections_test_1138@localhost/res1 in <presence from='bOb_notify_nested_collections_test_1138@localhost/res1' to='bob_notify_nested_collections_test_1138@localhost/res1' xml:lang='en'/>
*** User 2022-01-27 15:34:23.074 *** geralt_notify_nested_collections_test_1138@localhost/res1 out <open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-01-27 15:34:23.074 *** geralt_notify_nested_collections_test_1138@localhost/res1 in <open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='926adbdd05854eb8' from='localhost'/>
*** User 2022-01-27 15:34:23.074 *** geralt_notify_nested_collections_test_1138@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:23.074 *** geralt_notify_nested_collections_test_1138@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGdlcmFsdF9ub3RpZnlfbmVzdGVkX2NvbGxlY3Rpb25zX3Rlc3RfMTEzOAB3aXRjaGVy</auth>
*** User 2022-01-27 15:34:23.075 *** geralt_notify_nested_collections_test_1138@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:34:23.075 *** geralt_notify_nested_collections_test_1138@localhost/res1 out <open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-01-27 15:34:23.075 *** geralt_notify_nested_collections_test_1138@localhost/res1 in <open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='c7d4cd63bd23fe29' from='localhost'/>
*** User 2022-01-27 15:34:23.075 *** geralt_notify_nested_collections_test_1138@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:23.075 *** geralt_notify_nested_collections_test_1138@localhost/res1 out <iq type='set' id='d0a0878f5fc9c8f9cbad2a3b5b49aa00'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-27 15:34:23.075 *** geralt_notify_nested_collections_test_1138@localhost/res1 in <iq id='d0a0878f5fc9c8f9cbad2a3b5b49aa00' type='result' xmlns='jabber:client'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>geralt_notify_nested_collections_test_1138@localhost/res1</jid> </bind> </iq>
*** User 2022-01-27 15:34:23.075 *** geralt_notify_nested_collections_test_1138@localhost/res1 out <iq type='set' id='cd5b1ac1fb47e9df66a59f1c92a6b695'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:34:23.076 *** geralt_notify_nested_collections_test_1138@localhost/res1 in <iq type='result' id='cd5b1ac1fb47e9df66a59f1c92a6b695' xmlns='jabber:client'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:34:23.076 *** geralt_notify_nested_collections_test_1138@localhost/res1 out <presence/>
*** User 2022-01-27 15:34:23.076 *** geralt_notify_nested_collections_test_1138@localhost/res1 in <presence from='geralt_notify_nested_collections_test_1138@localhost/res1' to='geralt_notify_nested_collections_test_1138@localhost/res1' xmlns='jabber:client'/>
*** User 2022-01-27 15:34:23.076 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_M592VUYmUCM=-create_node' from='alicE_notify_nested_collections_test_1138@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='princely_musings_M592VUYmUCM='/> <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-27 15:34:23.078 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1138@localhost/res1' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_M592VUYmUCM=-create_node' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='princely_musings_M592VUYmUCM='/> </pubsub> </iq>
*** User 2022-01-27 15:34:23.078 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_qJy0rj9drCY=-create_node' from='alicE_notify_nested_collections_test_1138@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='princely_musings_qJy0rj9drCY='/> <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> <field var='pubsub#collection'> <value>princely_musings_M592VUYmUCM=</value> </field> </x> </configure> </pubsub> </iq>
*** User 2022-01-27 15:34:23.079 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1138@localhost/res1' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_qJy0rj9drCY=-create_node' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='princely_musings_qJy0rj9drCY='/> </pubsub> </iq>
*** User 2022-01-27 15:34:23.079 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-leaf_hqzZRVsA0Ic=-create_node' from='alicE_notify_nested_collections_test_1138@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='leaf_hqzZRVsA0Ic='/> <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_qJy0rj9drCY=</value> </field> </x> </configure> </pubsub> </iq>
*** User 2022-01-27 15:34:23.269 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1138@localhost/res1' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-leaf_hqzZRVsA0Ic=-create_node' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='leaf_hqzZRVsA0Ic='/> </pubsub> </iq>
*** User 2022-01-27 15:34:23.269 *** bOb_notify_nested_collections_test_1138@localhost/res1 out <iq to='pubsub.localhost' type='set' id='bOb_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_qJy0rj9drCY=-subscribe' from='bOb_notify_nested_collections_test_1138@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <subscribe node='princely_musings_qJy0rj9drCY=' jid='bOb_notify_nested_collections_test_1138@localhost/res1'/> </pubsub> </iq>
*** User 2022-01-27 15:34:23.270 *** bOb_notify_nested_collections_test_1138@localhost/res1 in <iq from='pubsub.localhost' to='bOb_notify_nested_collections_test_1138@localhost/res1' id='bOb_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_qJy0rj9drCY=-subscribe' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <subscription jid='bob_notify_nested_collections_test_1138@localhost/res1' subscription='subscribed' subid='1643-297663-269961' node='princely_musings_qJy0rj9drCY='/> </pubsub> </iq>
*** User 2022-01-27 15:34:23.270 *** geralt_notify_nested_collections_test_1138@localhost/res1 out <iq to='pubsub.localhost' type='set' id='geralt_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_M592VUYmUCM=-subscribe' from='geralt_notify_nested_collections_test_1138@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <subscribe node='princely_musings_M592VUYmUCM=' jid='geralt_notify_nested_collections_test_1138@localhost/res1'/> </pubsub> </iq>
*** User 2022-01-27 15:34:23.271 *** geralt_notify_nested_collections_test_1138@localhost/res1 in <iq from='pubsub.localhost' to='geralt_notify_nested_collections_test_1138@localhost/res1' id='geralt_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_M592VUYmUCM=-subscribe' type='result' xmlns='jabber:client'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <subscription jid='geralt_notify_nested_collections_test_1138@localhost/res1' subscription='subscribed' subid='1643-297663-271072' node='princely_musings_M592VUYmUCM='/> </pubsub> </iq>
*** User 2022-01-27 15:34:23.271 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-leaf_hqzZRVsA0Ic=-publish' from='alicE_notify_nested_collections_test_1138@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <publish node='leaf_hqzZRVsA0Ic='> <item id='item1'> <entry xmlns='http://www.w3.org/2005/Atom'/> </item> </publish> </pubsub> </iq>
*** User 2022-01-27 15:34:23.815 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1138@localhost/res1' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-leaf_hqzZRVsA0Ic=-publish' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <publish node='leaf_hqzZRVsA0Ic='> <item id='item1'/> </publish> </pubsub> </iq>
*** User 2022-01-27 15:34:23.815 *** bOb_notify_nested_collections_test_1138@localhost/res1 in <message from='pubsub.localhost' to='bob_notify_nested_collections_test_1138@localhost/res1' type='headline'> <event xmlns='http://jabber.org/protocol/pubsub#event'> <items node='leaf_hqzZRVsA0Ic='> <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_qJy0rj9drCY=</header> </headers> </message>
*** User 2022-01-27 15:34:23.815 *** geralt_notify_nested_collections_test_1138@localhost/res1 in <message from='pubsub.localhost' to='geralt_notify_nested_collections_test_1138@localhost/res1' type='headline' xmlns='jabber:client'> <event xmlns='http://jabber.org/protocol/pubsub#event'> <items node='leaf_hqzZRVsA0Ic='> <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_M592VUYmUCM=</header> </headers> </message>
*** User 2022-01-27 15:34:23.816 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-leaf_hqzZRVsA0Ic=-delete_node' from='alicE_notify_nested_collections_test_1138@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub#owner'> <delete node='leaf_hqzZRVsA0Ic='/> </pubsub> </iq>
*** User 2022-01-27 15:34:24.182 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1138@localhost/res1' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-leaf_hqzZRVsA0Ic=-delete_node' type='result'/>
*** User 2022-01-27 15:34:24.182 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_qJy0rj9drCY=-delete_node' from='alicE_notify_nested_collections_test_1138@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub#owner'> <delete node='princely_musings_qJy0rj9drCY='/> </pubsub> </iq>
*** User 2022-01-27 15:34:24.481 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1138@localhost/res1' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_qJy0rj9drCY=-delete_node' type='result'/>
*** User 2022-01-27 15:34:24.481 *** alicE_notify_nested_collections_test_1138@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_M592VUYmUCM=-delete_node' from='alicE_notify_nested_collections_test_1138@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub#owner'> <delete node='princely_musings_M592VUYmUCM='/> </pubsub> </iq>
*** User 2022-01-27 15:34:24.804 *** alicE_notify_nested_collections_test_1138@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1138@localhost/res1' id='alicE_notify_nested_collections_test_1138-pubsub.localhost-princely_musings_M592VUYmUCM=-delete_node' type='result'/>
*** User 2022-01-27 15:34:24.804 *** geralt_notify_nested_collections_test_1138@localhost/res1 out <close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-01-27 15:34:24.804 *** geralt_notify_nested_collections_test_1138@localhost/res1 in <close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-01-27 15:34:24.805 *** bOb_notify_nested_collections_test_1138@localhost/res1 out </stream:stream>
*** User 2022-01-27 15:34:24.805 *** bOb_notify_nested_collections_test_1138@localhost/res1 in </stream:stream>
*** User 2022-01-27 15:34:24.805 *** alicE_notify_nested_collections_test_1138@localhost/res1 out </stream:stream>
*** System report during pubsub_SUITE:notify_nested_collections_test/1 in 'dag+collection' 2022-01-27 15:34:24.805 *** =ERROR REPORT==== 27-Jan-2022::15:34:24.805287 === ** State machine <0.7852.1> terminating ** Last event = {cast,{ws_send,<0.7851.1>,#Ref<0.3928786125.941096961.164877>, close}} ** When server state = {connected, {state,<0.7851.1>, {up,#Ref<0.3928786125.941096961.164873>}, "localhost",5280,<<"http">>,"localhost",5280, [], #{protocols => [http],transport => tcp}, undefined,#Port<0.4211>,gun_tcp,true, {tcp,tcp_closed,tcp_error}, gun_http, {http_state,#Port<0.4211>,gun_tcp,#{}, 'HTTP/1.1',keepalive,<<>>,undefined,[], head, {0,0}, head}, undefined,gun_default_event_h,undefined}} ** Reason for termination = error:{'function not exported', {gun_http,ws_send,6}} ** Callback modules = [gun] ** Callback mode = state_functions ** Stacktrace = ** [{gun,connected,3, [{file,"/home/circleci/project/big_tests/_build/default/lib/gun/src/gun.erl"}, {line,1301}]}, {gen_statem,loop_state_callback,11,[{file,"gen_statem.erl"},{line,1194}]}, {proc_lib,init_p_do_apply,3,[{file,"proc_lib.erl"},{line,226}]}]
*** System report during pubsub_SUITE:notify_nested_collections_test/1 in 'dag+collection' 2022-01-27 15:34:24.805 *** =CRASH REPORT==== 27-Jan-2022::15:34:24.805752 === crasher: initial call: gun:init/1 pid: <0.7852.1> registered_name: [] exception error: undefined function gun_http:ws_send/6 in function gun:connected/3 (/home/circleci/project/big_tests/_build/default/lib/gun/src/gun.erl, line 1301) in call from gen_statem:loop_state_callback/11 (gen_statem.erl, line 1194) ancestors: [gun_conns_sup,gun_sup,<0.1301.0>] message_queue_len: 1 messages: [{'DOWN',#Ref<0.3928786125.941096961.164873>,process, <0.7851.1>,normal}] links: [<0.1303.0>,#Port<0.4211>] dictionary: [] trap_exit: false status: running heap_size: 6772 stack_size: 29 reductions: 18297 neighbours:
*** System report during pubsub_SUITE:notify_nested_collections_test/1 in 'dag+collection' 2022-01-27 15:34:24.806 *** =SUPERVISOR REPORT==== 27-Jan-2022::15:34:24.806170 === supervisor: {local,gun_conns_sup} errorContext: child_terminated reason: {undef, [{gun_http,ws_send, [close, {http_state,#Port<0.4211>,gun_tcp,#{},'HTTP/1.1', keepalive,<<>>,undefined,[],head, {0,0}, head}, #Ref<0.3928786125.941096961.164877>,<0.7851.1>, gun_default_event_h,undefined], []}, {gun,connected,3, [{file, "/home/circleci/project/big_tests/_build/default/lib/gun/src/gun.erl"}, {line,1301}]}, {gen_statem,loop_state_callback,11, [{file,"gen_statem.erl"},{line,1194}]}, {proc_lib,init_p_do_apply,3, [{file,"proc_lib.erl"},{line,226}]}]} offender: [{pid,<0.7852.1>}, {id,gun}, {mfargs,{gun,start_link,undefined}}, {restart_type,temporary}, {significant,false}, {shutdown,5000}, {child_type,worker}]
*** User 2022-01-27 15:34:25.126 *** alicE_notify_nested_collections_test_1138@localhost/res1 in </stream:stream>
=== Ended at 2022-01-27 15:34:25 === successfully completed test case === === Returned value: ok
Test run history | Top level test index | Latest test result