=== Test case: rest_client_SUITE:add_and_remove_some_contacts_with_nonexisting/1 (click for source code)

=== Config value:

    [{watchdog,<0.1986.2>},
     {muc_light_host,<<"muclight.domain.example.com">>},
     {mam_backend,rdbms},
     {mim_data_dir,"/home/circleci/project/big_tests/tests/rest_client_SUITE_data"},
     {preset,"pgsql_mnesia"},
     {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@df370d24fb6d.2022-05-11_08.56.40/big_tests.tests.rest_client_SUITE.logs/run.2022-05-11_09.04.42/rest_client_suite.add_and_remove_some_contacts_with_nonexisting.150914.html"},
     {tc_group_properties,[{name,roster},parallel]},
     {tc_group_path,[]},
     {data_dir,"/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/rest_client_SUITE_data/"},
     {priv_dir,"/home/circleci/project/big_tests/ct_report/ct_run.test@df370d24fb6d.2022-05-11_08.56.40/big_tests.tests.rest_client_SUITE.logs/run.2022-05-11_09.04.42/log_private/"},
     {{saved_modules,mongooseim@localhost,<<"test type">>},
      #{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 => #{iqdisc => no_queue},
        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"}],
              iqdisc => one_queue,password_strength => 0,
              registration_watchers => []},
        mod_roster =>
            #{backend => rdbms,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 => rdbms,
              host => {prefix,<<"vjud.">>},
              iqdisc => parallel,matches => 30,search => true}}}]

=== Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@df370d24fb6d.2022-05-11_08.56.40"

=== Started at 2022-05-11 09:04:45


*** CT 2022-05-11 09:04:45.353 *** View log from node mongooseim@localhost when started mongooseim@localhost_2607.html
*** CT 2022-05-11 09:04:45.354 *** View log from node ejabberd2@localhost when started ejabberd2@localhost_524.html

*** User 2022-05-11 09:04:45.371 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2022-05-11 09:04:45.372 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='6a02fb28b19a3466' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-11 09:04:45.372 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/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-05-11 09:04:45.372 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX2FkZF9hbmRfcmVtb3ZlX3NvbWVfY29udGFjdHNfd2l0aF9ub25leGlzdGluZ18yMDI4AG1hdHlncnlzYQ==</auth>



*** User 2022-05-11 09:04:45.373 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-05-11 09:04:45.373 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2022-05-11 09:04:45.373 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='7505e82799c8d9bf' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-11 09:04:45.373 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/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-05-11 09:04:45.373 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<iq type='set' id='6bbfdd6927b8db1cbcdada80a8ecb22a'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-05-11 09:04:45.374 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq id='6bbfdd6927b8db1cbcdada80a8ecb22a' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-05-11 09:04:45.374 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<iq type='set' id='64d4bfbbda9a79469459faf44fd3fb79'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-11 09:04:45.374 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq type='result' id='64d4bfbbda9a79469459faf44fd3fb79'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-11 09:04:45.374 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<presence/>



*** User 2022-05-11 09:04:45.375 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<presence from='alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' to='alice_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' xml:lang='en'/>



*** User 2022-05-11 09:04:45.376 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2022-05-11 09:04:45.376 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='ed45c6be6404dcb7' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-11 09:04:45.377 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/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-05-11 09:04:45.377 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9hZGRfYW5kX3JlbW92ZV9zb21lX2NvbnRhY3RzX3dpdGhfbm9uZXhpc3RpbmdfMjAyOABtYWtyb2xpa2E=</auth>



*** User 2022-05-11 09:04:45.377 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-05-11 09:04:45.377 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2022-05-11 09:04:45.378 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d3f2e13cdd6c79cd' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-11 09:04:45.378 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/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-05-11 09:04:45.378 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<iq type='set' id='b65836746710f1944907f9911960d5ca'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-05-11 09:04:45.378 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq id='b65836746710f1944907f9911960d5ca' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-05-11 09:04:45.378 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<iq type='set' id='4eaf5ea83a922ceb9e6188e571b7dabf'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-11 09:04:45.378 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq type='result' id='4eaf5ea83a922ceb9e6188e571b7dabf'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-11 09:04:45.378 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<presence/>



*** User 2022-05-11 09:04:45.380 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<presence from='bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' to='bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' xml:lang='en'/>



*** User 2022-05-11 09:04:45.380 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2022-05-11 09:04:45.381 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='7ca9bcae167e46f9' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-11 09:04:45.381 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/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-05-11 09:04:45.381 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGthdGVfYWRkX2FuZF9yZW1vdmVfc29tZV9jb250YWN0c193aXRoX25vbmV4aXN0aW5nXzIwMjgAbWFrcm93ZTtw</auth>



*** User 2022-05-11 09:04:45.381 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-05-11 09:04:45.382 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2022-05-11 09:04:45.382 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3265145e9213fd44' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-11 09:04:45.382 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/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-05-11 09:04:45.382 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<iq type='set' id='8a612783634eaf3c3eff554cbe846025'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-05-11 09:04:45.382 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq id='8a612783634eaf3c3eff554cbe846025' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-05-11 09:04:45.382 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<iq type='set' id='5f4ed4e67eccd9649902f5c217b5ec61'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-11 09:04:45.383 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq type='result' id='5f4ed4e67eccd9649902f5c217b5ec61'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-11 09:04:45.383 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<presence/>



*** User 2022-05-11 09:04:45.385 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<presence from='kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' to='kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' xml:lang='en'/>



*** User 2022-05-11 09:04:45.386 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2022-05-11 09:04:45.386 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='000104b5f96ea59e' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-11 09:04:45.386 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/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-05-11 09:04:45.386 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AG1pa2VfYWRkX2FuZF9yZW1vdmVfc29tZV9jb250YWN0c193aXRoX25vbmV4aXN0aW5nXzIwMjgAbmljbmllbWE=</auth>



*** User 2022-05-11 09:04:45.387 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-05-11 09:04:45.387 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2022-05-11 09:04:45.387 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='5fe7eca57295a7fc' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-11 09:04:45.388 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/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-05-11 09:04:45.388 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<iq type='set' id='d1251607c301665e6e6bdf9fc1a4f859'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-05-11 09:04:45.388 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq id='d1251607c301665e6e6bdf9fc1a4f859' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-05-11 09:04:45.388 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<iq type='set' id='2bb3aefaa5538e3984fd3c94ae6c8e5e'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-11 09:04:45.388 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq type='result' id='2bb3aefaa5538e3984fd3c94ae6c8e5e'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-11 09:04:45.388 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
<presence/>



*** User 2022-05-11 09:04:45.391 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<presence from='mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' to='mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' xml:lang='en'/>



*** User 2022-05-11 09:04:45.408 ***
REST request:
Code: 204
Req: {<0.2097.2>,<<"/api/contacts">>,<<"POST">>,
      [{<<"Content-Type">>,<<"application/json">>},
       {<<"Request-Id">>,<<"6122fabcacee3ac2">>},
       {<<"authorization">>,
        <<"Basic Ym9iX2FkZF9hbmRfcmVtb3ZlX3NvbWVfY29udGFjdHNfd2l0aF9ub25leGlzdGluZ18yMDI4QGRvbWFpbi5leGFtcGxlLmNvbTptYWtyb2xpa2E=">>}],
      <<"{\"jid\":\"alice_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\"}">>}
Result: {{<<"204">>,<<"No Content">>},
         [{<<"server">>,<<"Cowboy">>},
          {<<"date">>,<<"Wed, 11 May 2022 09:04:45 GMT">>}],
         <<>>,80,8477}
Params: #{body =>
              <<"{\"jid\":\"alice_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\"}">>,
          creds =>
              {<<"bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com">>,
               <<"makrolika">>},
          method => <<"POST">>,path => <<"/api/contacts">>,
          return_headers => true,role => client,
          server => #{node => mongooseim@localhost}}


*** User 2022-05-11 09:04:45.409 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq from='bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com' to='bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' id='pushb1c854b33e2aef30' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='none' jid='alice_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-11 09:04:45.421 ***
REST request:
Code: 204
Req: {<0.2130.2>,<<"/api/contacts">>,<<"POST">>,
      [{<<"Content-Type">>,<<"application/json">>},
       {<<"Request-Id">>,<<"ba08aace93d680ad">>},
       {<<"authorization">>,
        <<"Basic Ym9iX2FkZF9hbmRfcmVtb3ZlX3NvbWVfY29udGFjdHNfd2l0aF9ub25leGlzdGluZ18yMDI4QGRvbWFpbi5leGFtcGxlLmNvbTptYWtyb2xpa2E=">>}],
      <<"{\"jid\":\"kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\"}">>}
Result: {{<<"204">>,<<"No Content">>},
         [{<<"server">>,<<"Cowboy">>},
          {<<"date">>,<<"Wed, 11 May 2022 09:04:45 GMT">>}],
         <<>>,80,3591}
Params: #{body =>
              <<"{\"jid\":\"kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\"}">>,
          creds =>
              {<<"bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com">>,
               <<"makrolika">>},
          method => <<"POST">>,path => <<"/api/contacts">>,
          return_headers => true,role => client,
          server => #{node => mongooseim@localhost}}


*** User 2022-05-11 09:04:45.421 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq from='bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com' to='bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' id='push3a7ba2a6b3715661' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='none' jid='kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-11 09:04:45.432 ***
REST request:
Code: 200
Req: {<0.2159.2>,<<"/api/contacts">>,<<"DELETE">>,
      [{<<"Content-Type">>,<<"application/json">>},
       {<<"Request-Id">>,<<"e4d4e5046fc6810f">>},
       {<<"authorization">>,
        <<"Basic Ym9iX2FkZF9hbmRfcmVtb3ZlX3NvbWVfY29udGFjdHNfd2l0aF9ub25leGlzdGluZ18yMDI4QGRvbWFpbi5leGFtcGxlLmNvbTptYWtyb2xpa2E=">>}],
      <<"{\"to_delete\":[\"alice_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\",\"kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\",\"mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\"]}">>}
Result: {{<<"200">>,<<"OK">>},
         [{<<"server">>,<<"Cowboy">>},
          {<<"date">>,<<"Wed, 11 May 2022 09:04:45 GMT">>},
          {<<"content-type">>,<<"application/json">>},
          {<<"content-length">>,<<"94">>}],
         <<"{\"not_deleted\":[\"mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\"]}">>,
         218,4469}
Params: #{body =>
              <<"{\"to_delete\":[\"alice_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\",\"kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\",\"mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com\"]}">>,
          creds =>
              {<<"bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com">>,
               <<"makrolika">>},
          method => <<"DELETE">>,path => <<"/api/contacts">>,
          return_headers => true,role => client,
          server => #{node => mongooseim@localhost}}


*** User 2022-05-11 09:04:45.485 ***
REST request:
Code: 200
Req: {<0.2187.2>,<<"/api/contacts">>,<<"GET">>,
      [{<<"Content-Type">>,<<"application/json">>},
       {<<"Request-Id">>,<<"a8083c1414b396ec">>},
       {<<"authorization">>,
        <<"Basic Ym9iX2FkZF9hbmRfcmVtb3ZlX3NvbWVfY29udGFjdHNfd2l0aF9ub25leGlzdGluZ18yMDI4QGRvbWFpbi5leGFtcGxlLmNvbTptYWtyb2xpa2E=">>}],
      <<>>}
Result: {{<<"200">>,<<"OK">>},
         [{<<"server">>,<<"Cowboy">>},
          {<<"date">>,<<"Wed, 11 May 2022 09:04:45 GMT">>},
          {<<"content-type">>,<<"application/json">>},
          {<<"content-length">>,<<"2">>}],
         <<"[]">>,125,2211}
Params: #{body => <<>>,
          creds =>
              {<<"bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com">>,
               <<"makrolika">>},
          method => <<"GET">>,path => <<"/api/contacts">>,
          return_headers => true,role => client,
          server => #{node => mongooseim@localhost}}


*** User 2022-05-11 09:04:45.485 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
<iq from='bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com' to='bob_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1' id='pushbc079d2003fa94ba' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='remove' jid='alice_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-11 09:04:45.485 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
</stream:stream>

*** User 2022-05-11 09:04:45.485 ***
mike_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
</stream:stream>

*** User 2022-05-11 09:04:45.485 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
</stream:stream>

*** User 2022-05-11 09:04:45.486 ***
kate_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
</stream:stream>

*** User 2022-05-11 09:04:45.486 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
</stream:stream>

*** User 2022-05-11 09:04:45.486 ***
bOb_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
</stream:stream>

*** User 2022-05-11 09:04:45.486 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 out
</stream:stream>

*** User 2022-05-11 09:04:45.486 ***
alicE_add_and_remove_some_contacts_with_nonexisting_2028@domain.example.com/res1 in
</stream:stream>
*** CT 2022-05-11 09:04:45.488 *** View log from node ejabberd2@localhost when finished ejabberd2@localhost_524.html
*** CT 2022-05-11 09:04:45.489 *** View log from node mongooseim@localhost when finished mongooseim@localhost_2607.html



=== Ended at 2022-05-11 09:04:45
=== successfully completed test case
=== === Returned value: ok