=== Test case: pubsub_SUITE:notify_nested_collections_test/1 (click for source code) === Config value: [{watchdog,<0.8437.1>}, {mim_data_dir,"/home/circleci/project/big_tests/tests/pubsub_SUITE_data"}, {preset,"ldap_mnesia"}, {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@fbe05ecb9552.2022-03-18_10.50.03/big_tests.tests.pubsub_SUITE.logs/run.2022-03-18_10.58.29/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@fbe05ecb9552.2022-03-18_10.50.03/big_tests.tests.pubsub_SUITE.logs/run.2022-03-18_10.58.29/log_private/"}, {{saved_modules,mongooseim@localhost,<<"localhost">>}, #{mod_adhoc => #{iqdisc => one_queue,report_commands_node => false}, mod_amp => [], mod_bosh => #{backend => mnesia,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}, mod_cache_users => #{number_of_segments => 5,strategy => fifo,time_to_live => 2}, mod_carboncopy => [],mod_commands => [], mod_disco => #{extra_domains => [],iqdisc => one_queue,server_info => [], 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 => mnesia,iqdisc => one_queue,store_current_id => false, versioning => false}, mod_sic => #{iqdisc => one_queue}, mod_stream_management => #{ack => true,ack_freq => 1,backend => mnesia,buffer => true, buffer_max => 100,resume_timeout => 600, stale_h => #{enabled => false,geriatric => 3600,repeat_after => 1800}}, mod_vcard => #{backend => ldap, host => {prefix,<<"vjud.">>}, iqdisc => parallel, ldap => #{base => <<"ou=Users,dc=esl,dc=com">>, binary_search_fields => [],deref => never, filter => <<"(objectClass=inetOrgPerson)">>, pool_tag => default, search_fields => [{<<"User">>,<<"%u">>}, {<<"Full Name">>,<<"displayName">>}, {<<"Given Name">>,<<"givenName">>}, {<<"Middle Name">>,<<"initials">>}, {<<"Family Name">>,<<"sn">>}, {<<"Nickname">>,<<"%u">>}, {<<"Birthday">>,<<"birthDay">>}, {<<"Country">>,<<"c">>}, {<<"City">>,<<"l">>}, {<<"Email">>,<<"mail">>}, {<<"Organization Name">>,<<"o">>}, {<<"Organization Unit">>,<<"ou">>}], search_operator => 'and', search_reported => [{<<"Full Name">>,<<"FN">>}, {<<"Given Name">>,<<"FIRST">>}, {<<"Middle Name">>,<<"MIDDLE">>}, {<<"Family Name">>,<<"LAST">>}, {<<"Nickname">>,<<"NICK">>}, {<<"Birthday">>,<<"BDAY">>}, {<<"Country">>,<<"CTRY">>}, {<<"City">>,<<"LOCALITY">>}, {<<"Email">>,<<"EMAIL">>}, {<<"Organization Name">>,<<"ORGNAME">>}, {<<"Organization Unit">>,<<"ORGUNIT">>}], uids => [{<<"uid">>,<<"%u">>}], vcard_map => [{<<"NICKNAME">>,<<"%u">>,[]}, {<<"FN">>,<<"%s">>,[<<"displayName">>]}, {<<"FAMILY">>,<<"%s">>,[<<"sn">>]}, {<<"GIVEN">>,<<"%s">>,[<<"givenName">>]}, {<<"MIDDLE">>,<<"%s">>,[<<"initials">>]}, {<<"ORGNAME">>,<<"%s">>,[<<"o">>]}, {<<"ORGUNIT">>,<<"%s">>,[<<"ou">>]}, {<<"CTRY">>,<<"%s">>,[<<"c">>]}, {<<"LOCALITY">>,<<"%s">>,[<<"l">>]}, {<<"STREET">>,<<"%s">>,[<<"street">>]}, {<<"REGION">>,<<"%s">>,[<<"st">>]}, {<<"PCODE">>,<<"%s">>,[<<"postalCode">>]}, {<<"TITLE">>,<<"%s">>,[<<"title">>]}, {<<"URL">>,<<"%s">>,[<<"labeleduri">>]}, {<<"DESC">>,<<"%s">>,[<<"description">>]}, {<<"TEL">>,<<"%s">>,[<<"telephoneNumber">>]}, {<<"EMAIL">>,<<"%s">>,[<<"mail">>]}, {<<"BDAY">>,<<"%s">>,[<<"birthDay">>]}, {<<"ROLE">>,<<"%s">>,[<<"employeeType">>]}, {<<"PHOTO">>,<<"%s">>,[<<"jpegPhoto">>]}]}, matches => 30,search => true}}}] === Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@fbe05ecb9552.2022-03-18_10.50.03" === Started at 2022-03-18 10:58:48
*** User 2022-03-18 10:58:48.944 *** alicE_notify_nested_collections_test_1283@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-03-18 10:58:48.944 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='100fa5f25b2de888' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-03-18 10:58:48.944 *** alicE_notify_nested_collections_test_1283@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>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-03-18 10:58:48.944 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX25vdGlmeV9uZXN0ZWRfY29sbGVjdGlvbnNfdGVzdF8xMjgzAG1hdHlncnlzYQ==</auth>
*** User 2022-03-18 10:58:48.945 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-03-18 10:58:48.945 *** alicE_notify_nested_collections_test_1283@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-03-18 10:58:48.945 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='c9b3daa4bfeb3cd5' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-03-18 10:58:48.946 *** alicE_notify_nested_collections_test_1283@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-03-18 10:58:48.946 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <iq type='set' id='4b793e815a97dc80774c3ed5466326f7'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-03-18 10:58:48.946 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <iq id='4b793e815a97dc80774c3ed5466326f7' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alicE_notify_nested_collections_test_1283@localhost/res1</jid> </bind> </iq>
*** User 2022-03-18 10:58:48.946 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <iq type='set' id='5665baeda3b2961b77094c13166aafe6'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-03-18 10:58:48.946 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <iq type='result' id='5665baeda3b2961b77094c13166aafe6'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-03-18 10:58:48.946 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <presence/>
*** User 2022-03-18 10:58:48.947 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <presence from='alicE_notify_nested_collections_test_1283@localhost/res1' to='alice_notify_nested_collections_test_1283@localhost/res1' xml:lang='en'/>
*** User 2022-03-18 10:58:48.947 *** bOb_notify_nested_collections_test_1283@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-03-18 10:58:48.948 *** bOb_notify_nested_collections_test_1283@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='9263a10521b82f21' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-03-18 10:58:48.948 *** bOb_notify_nested_collections_test_1283@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>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-03-18 10:58:48.948 *** bOb_notify_nested_collections_test_1283@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9ub3RpZnlfbmVzdGVkX2NvbGxlY3Rpb25zX3Rlc3RfMTI4MwBtYWtyb2xpa2E=</auth>
*** User 2022-03-18 10:58:48.949 *** bOb_notify_nested_collections_test_1283@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-03-18 10:58:48.949 *** bOb_notify_nested_collections_test_1283@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-03-18 10:58:48.949 *** bOb_notify_nested_collections_test_1283@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='bd07d62588d68921' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-03-18 10:58:48.949 *** bOb_notify_nested_collections_test_1283@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-03-18 10:58:48.949 *** bOb_notify_nested_collections_test_1283@localhost/res1 out <iq type='set' id='0f14d1a72c341bbe1cf1687d6b47ac31'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-03-18 10:58:48.949 *** bOb_notify_nested_collections_test_1283@localhost/res1 in <iq id='0f14d1a72c341bbe1cf1687d6b47ac31' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>bOb_notify_nested_collections_test_1283@localhost/res1</jid> </bind> </iq>
*** User 2022-03-18 10:58:48.949 *** bOb_notify_nested_collections_test_1283@localhost/res1 out <iq type='set' id='9a15e42a8f37b9d76a8fc96a52b8d2d9'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-03-18 10:58:48.950 *** bOb_notify_nested_collections_test_1283@localhost/res1 in <iq type='result' id='9a15e42a8f37b9d76a8fc96a52b8d2d9'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-03-18 10:58:48.950 *** bOb_notify_nested_collections_test_1283@localhost/res1 out <presence/>
*** User 2022-03-18 10:58:48.950 *** bOb_notify_nested_collections_test_1283@localhost/res1 in <presence from='bOb_notify_nested_collections_test_1283@localhost/res1' to='bob_notify_nested_collections_test_1283@localhost/res1' xml:lang='en'/>
*** User 2022-03-18 10:58:48.951 *** geralt_notify_nested_collections_test_1283@localhost/res1 out <open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-03-18 10:58:48.952 *** geralt_notify_nested_collections_test_1283@localhost/res1 in <open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='3b7c8f7ff3e74805' from='localhost'/>
*** User 2022-03-18 10:58:48.952 *** geralt_notify_nested_collections_test_1283@localhost/res1 in <features xmlns='http://etherx.jabber.org/streams'> <mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'> <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-03-18 10:58:48.952 *** geralt_notify_nested_collections_test_1283@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGdlcmFsdF9ub3RpZnlfbmVzdGVkX2NvbGxlY3Rpb25zX3Rlc3RfMTI4MwB3aXRjaGVy</auth>
*** User 2022-03-18 10:58:48.953 *** geralt_notify_nested_collections_test_1283@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-03-18 10:58:48.953 *** geralt_notify_nested_collections_test_1283@localhost/res1 out <open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-03-18 10:58:48.953 *** geralt_notify_nested_collections_test_1283@localhost/res1 in <open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='f63ba41357f0182f' from='localhost'/>
*** User 2022-03-18 10:58:48.953 *** geralt_notify_nested_collections_test_1283@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-03-18 10:58:48.953 *** geralt_notify_nested_collections_test_1283@localhost/res1 out <iq type='set' id='daa76105d424118c6b41ec918102434e'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-03-18 10:58:48.953 *** geralt_notify_nested_collections_test_1283@localhost/res1 in <iq id='daa76105d424118c6b41ec918102434e' type='result' xmlns='jabber:client'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>geralt_notify_nested_collections_test_1283@localhost/res1</jid> </bind> </iq>
*** User 2022-03-18 10:58:48.954 *** geralt_notify_nested_collections_test_1283@localhost/res1 out <iq type='set' id='fc17fb7dc46381ef34c8dab7d061d0df'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-03-18 10:58:48.954 *** geralt_notify_nested_collections_test_1283@localhost/res1 in <iq type='result' id='fc17fb7dc46381ef34c8dab7d061d0df' xmlns='jabber:client'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-03-18 10:58:48.954 *** geralt_notify_nested_collections_test_1283@localhost/res1 out <presence/>
*** User 2022-03-18 10:58:48.954 *** geralt_notify_nested_collections_test_1283@localhost/res1 in <presence from='geralt_notify_nested_collections_test_1283@localhost/res1' to='geralt_notify_nested_collections_test_1283@localhost/res1' xmlns='jabber:client'/>
*** User 2022-03-18 10:58:48.955 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_749DtBx4xP0=-create_node' from='alicE_notify_nested_collections_test_1283@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='princely_musings_749DtBx4xP0='/> <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-03-18 10:58:48.956 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1283@localhost/res1' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_749DtBx4xP0=-create_node' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='princely_musings_749DtBx4xP0='/> </pubsub> </iq>
*** User 2022-03-18 10:58:48.956 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_gj5lViO3rj8=-create_node' from='alicE_notify_nested_collections_test_1283@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='princely_musings_gj5lViO3rj8='/> <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_749DtBx4xP0=</value> </field> </x> </configure> </pubsub> </iq>
*** User 2022-03-18 10:58:48.958 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1283@localhost/res1' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_gj5lViO3rj8=-create_node' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='princely_musings_gj5lViO3rj8='/> </pubsub> </iq>
*** User 2022-03-18 10:58:48.958 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-leaf_P/Fm3550xZg=-create_node' from='alicE_notify_nested_collections_test_1283@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='leaf_P/Fm3550xZg='/> <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_gj5lViO3rj8=</value> </field> </x> </configure> </pubsub> </iq>
*** User 2022-03-18 10:58:49.145 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1283@localhost/res1' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-leaf_P/Fm3550xZg=-create_node' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <create node='leaf_P/Fm3550xZg='/> </pubsub> </iq>
*** User 2022-03-18 10:58:49.145 *** bOb_notify_nested_collections_test_1283@localhost/res1 out <iq to='pubsub.localhost' type='set' id='bOb_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_gj5lViO3rj8=-subscribe' from='bOb_notify_nested_collections_test_1283@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <subscribe node='princely_musings_gj5lViO3rj8=' jid='bOb_notify_nested_collections_test_1283@localhost/res1'/> </pubsub> </iq>
*** User 2022-03-18 10:58:49.146 *** bOb_notify_nested_collections_test_1283@localhost/res1 in <iq from='pubsub.localhost' to='bOb_notify_nested_collections_test_1283@localhost/res1' id='bOb_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_gj5lViO3rj8=-subscribe' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <subscription jid='bob_notify_nested_collections_test_1283@localhost/res1' subscription='subscribed' subid='1647-601129-145745' node='princely_musings_gj5lViO3rj8='/> </pubsub> </iq>
*** User 2022-03-18 10:58:49.146 *** geralt_notify_nested_collections_test_1283@localhost/res1 out <iq to='pubsub.localhost' type='set' id='geralt_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_749DtBx4xP0=-subscribe' from='geralt_notify_nested_collections_test_1283@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <subscribe node='princely_musings_749DtBx4xP0=' jid='geralt_notify_nested_collections_test_1283@localhost/res1'/> </pubsub> </iq>
*** User 2022-03-18 10:58:49.146 *** geralt_notify_nested_collections_test_1283@localhost/res1 in <iq from='pubsub.localhost' to='geralt_notify_nested_collections_test_1283@localhost/res1' id='geralt_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_749DtBx4xP0=-subscribe' type='result' xmlns='jabber:client'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <subscription jid='geralt_notify_nested_collections_test_1283@localhost/res1' subscription='subscribed' subid='1647-601129-146632' node='princely_musings_749DtBx4xP0='/> </pubsub> </iq>
*** User 2022-03-18 10:58:49.147 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-leaf_P/Fm3550xZg=-publish' from='alicE_notify_nested_collections_test_1283@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <publish node='leaf_P/Fm3550xZg='> <item id='item1'> <entry xmlns='http://www.w3.org/2005/Atom'/> </item> </publish> </pubsub> </iq>
*** User 2022-03-18 10:58:49.691 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1283@localhost/res1' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-leaf_P/Fm3550xZg=-publish' type='result'> <pubsub xmlns='http://jabber.org/protocol/pubsub'> <publish node='leaf_P/Fm3550xZg='> <item id='item1'/> </publish> </pubsub> </iq>
*** User 2022-03-18 10:58:49.691 *** bOb_notify_nested_collections_test_1283@localhost/res1 in <message from='pubsub.localhost' to='bob_notify_nested_collections_test_1283@localhost/res1' type='headline'> <event xmlns='http://jabber.org/protocol/pubsub#event'> <items node='leaf_P/Fm3550xZg='> <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_gj5lViO3rj8=</header> </headers> </message>
*** User 2022-03-18 10:58:49.692 *** geralt_notify_nested_collections_test_1283@localhost/res1 in <message from='pubsub.localhost' to='geralt_notify_nested_collections_test_1283@localhost/res1' type='headline' xmlns='jabber:client'> <event xmlns='http://jabber.org/protocol/pubsub#event'> <items node='leaf_P/Fm3550xZg='> <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_749DtBx4xP0=</header> </headers> </message>
*** User 2022-03-18 10:58:49.692 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-leaf_P/Fm3550xZg=-delete_node' from='alicE_notify_nested_collections_test_1283@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub#owner'> <delete node='leaf_P/Fm3550xZg='/> </pubsub> </iq>
*** User 2022-03-18 10:58:50.059 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1283@localhost/res1' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-leaf_P/Fm3550xZg=-delete_node' type='result'/>
*** User 2022-03-18 10:58:50.059 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_gj5lViO3rj8=-delete_node' from='alicE_notify_nested_collections_test_1283@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub#owner'> <delete node='princely_musings_gj5lViO3rj8='/> </pubsub> </iq>
*** User 2022-03-18 10:58:50.358 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1283@localhost/res1' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_gj5lViO3rj8=-delete_node' type='result'/>
*** User 2022-03-18 10:58:50.358 *** alicE_notify_nested_collections_test_1283@localhost/res1 out <iq to='pubsub.localhost' type='set' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_749DtBx4xP0=-delete_node' from='alicE_notify_nested_collections_test_1283@localhost/res1'> <pubsub xmlns='http://jabber.org/protocol/pubsub#owner'> <delete node='princely_musings_749DtBx4xP0='/> </pubsub> </iq>
*** User 2022-03-18 10:58:50.682 *** alicE_notify_nested_collections_test_1283@localhost/res1 in <iq from='pubsub.localhost' to='alicE_notify_nested_collections_test_1283@localhost/res1' id='alicE_notify_nested_collections_test_1283-pubsub.localhost-princely_musings_749DtBx4xP0=-delete_node' type='result'/>
*** User 2022-03-18 10:58:50.682 *** geralt_notify_nested_collections_test_1283@localhost/res1 out <close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-03-18 10:58:50.683 *** geralt_notify_nested_collections_test_1283@localhost/res1 in <close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-03-18 10:58:50.683 *** bOb_notify_nested_collections_test_1283@localhost/res1 out </stream:stream>
*** User 2022-03-18 10:58:50.683 *** bOb_notify_nested_collections_test_1283@localhost/res1 in </stream:stream>
*** User 2022-03-18 10:58:50.683 *** alicE_notify_nested_collections_test_1283@localhost/res1 out </stream:stream>
*** System report during pubsub_SUITE:notify_nested_collections_test/1 in 'dag+collection' 2022-03-18 10:58:50.684 *** =ERROR REPORT==== 18-Mar-2022::10:58:50.683970 === ** State machine <0.8628.1> terminating ** Last event = {cast,{ws_send,<0.8627.1>, #Ref<0.3071861660.1588068353.222857>,close}} ** When server state = {connected, {state,<0.8627.1>, {up,#Ref<0.3071861660.1588068353.222853>}, "localhost",5280,<<"http">>,"localhost",5280, [], #{protocols => [http],transport => tcp}, undefined,#Port<0.4425>,gun_tcp,true, {tcp,tcp_closed,tcp_error}, gun_http, {http_state,#Port<0.4425>,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-03-18 10:58:50.685 *** =CRASH REPORT==== 18-Mar-2022::10:58:50.684964 === crasher: initial call: gun:init/1 pid: <0.8628.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.1316.0>] message_queue_len: 1 messages: [{'DOWN',#Ref<0.3071861660.1588068353.222853>,process, <0.8627.1>,normal}] links: [<0.1318.0>,#Port<0.4425>] dictionary: [] trap_exit: false status: running heap_size: 10958 stack_size: 29 reductions: 18077 neighbours:
*** System report during pubsub_SUITE:notify_nested_collections_test/1 in 'dag+collection' 2022-03-18 10:58:50.687 *** =SUPERVISOR REPORT==== 18-Mar-2022::10:58:50.687304 === supervisor: {local,gun_conns_sup} errorContext: child_terminated reason: {undef, [{gun_http,ws_send, [close, {http_state,#Port<0.4425>,gun_tcp,#{},'HTTP/1.1', keepalive,<<>>,undefined,[],head, {0,0}, head}, #Ref<0.3071861660.1588068353.222857>,<0.8627.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.8628.1>}, {id,gun}, {mfargs,{gun,start_link,undefined}}, {restart_type,temporary}, {significant,false}, {shutdown,5000}, {child_type,worker}]
*** User 2022-03-18 10:58:51.003 *** alicE_notify_nested_collections_test_1283@localhost/res1 in </stream:stream>
=== Ended at 2022-03-18 10:58:51 === successfully completed test case === === Returned value: ok
Test run history | Top level test index | Latest test result