=== Test case: presence_SUITE:subscribe_relog/1 (click for source code)

=== Config value:

    [{watchdog,<0.11749.1>},
     {preset,"ldap_mnesia"},
     {mim_data_dir,"/home/circleci/project/big_tests/tests/presence_SUITE_data"},
     {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@85680c760e4e.2024-04-25_16.15.48/big_tests.tests.presence_SUITE.logs/run.2024-04-25_16.27.05/presence_suite.subscribe_relog.84098.html"},
     {tc_group_properties,[{name,subscribe_group},parallel]},
     {tc_group_path,[]},
     {data_dir,"/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/presence_SUITE_data/"},
     {priv_dir,"/home/circleci/project/big_tests/ct_report/ct_run.test@85680c760e4e.2024-04-25_16.15.48/big_tests.tests.presence_SUITE.logs/run.2024-04-25_16.27.05/log_private/"},
     {escalus_users,[{alice,[{username,<<"alicE">>},
                             {server,<<"localhost">>},
                             {password,<<"matygrysa">>}]},
                     {bob,[{username,<<"bOb">>},
                           {server,<<"localhost">>},
                           {password,<<"makrolika">>}]}]}]

=== Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@85680c760e4e.2024-04-25_16.15.48"

=== Started at 2024-04-25 16:27:06


*** CT 2024-04-25 16:27:06.972 *** View log from node mongooseim@localhost when started🔗 mongooseim@localhost_4193.html

*** User 2024-04-25 16:27:07.062 ***🔗
alicE_subscribe_relog_1464@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-25 16:27:07.062 ***🔗
alicE_subscribe_relog_1464@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='bc350e28f7f134dd' from='localhost' version='1.0' xml:lang='en'>

*** User 2024-04-25 16:27:07.063 ***🔗
alicE_subscribe_relog_1464@localhost/res1 in
<stream:features>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
	<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
		<mechanism>PLAIN</mechanism>
	</mechanisms>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-25 16:27:07.063 ***🔗
alicE_subscribe_relog_1464@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3N1YnNjcmliZV9yZWxvZ18xNDY0AG1hdHlncnlzYQ==</auth>



*** User 2024-04-25 16:27:07.064 ***🔗
alicE_subscribe_relog_1464@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2024-04-25 16:27:07.064 ***🔗
alicE_subscribe_relog_1464@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-25 16:27:07.064 ***🔗
alicE_subscribe_relog_1464@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='64d02d3f0ab3c21c' from='localhost' version='1.0' xml:lang='en' to='alice_subscribe_relog_1464@localhost'>

*** User 2024-04-25 16:27:07.065 ***🔗
alicE_subscribe_relog_1464@localhost/res1 in
<stream:features>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-25 16:27:07.065 ***🔗
alicE_subscribe_relog_1464@localhost/res1 out
<iq type='set' id='4c3c1297e5a96a557759b8ab6a3ea521'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2024-04-25 16:27:07.065 ***🔗
alicE_subscribe_relog_1464@localhost/res1 in
<iq id='4c3c1297e5a96a557759b8ab6a3ea521' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>alice_subscribe_relog_1464@localhost/res1</jid>
	</bind>
</iq>



*** User 2024-04-25 16:27:07.065 ***🔗
alice_subscribe_relog_1464@localhost/res1 out
<iq type='set' id='71f69ea3fb4adc3d584e9de132e49d03'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-25 16:27:07.066 ***🔗
alice_subscribe_relog_1464@localhost/res1 in
<iq from='localhost' to='alice_subscribe_relog_1464@localhost/res1' id='71f69ea3fb4adc3d584e9de132e49d03' type='result'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-25 16:27:07.066 ***🔗
alice_subscribe_relog_1464@localhost/res1 out
<presence/>



*** User 2024-04-25 16:27:07.067 ***🔗
alice_subscribe_relog_1464@localhost/res1 in
<presence from='alice_subscribe_relog_1464@localhost/res1' to='alice_subscribe_relog_1464@localhost/res1'/>



*** User 2024-04-25 16:27:07.067 ***🔗
bOb_subscribe_relog_1464@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-25 16:27:07.068 ***🔗
bOb_subscribe_relog_1464@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='c775f21c91115080' from='localhost' version='1.0' xml:lang='en'>

*** User 2024-04-25 16:27:07.068 ***🔗
bOb_subscribe_relog_1464@localhost/res1 in
<stream:features>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
	<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
		<mechanism>PLAIN</mechanism>
	</mechanisms>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-25 16:27:07.068 ***🔗
bOb_subscribe_relog_1464@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9zdWJzY3JpYmVfcmVsb2dfMTQ2NABtYWtyb2xpa2E=</auth>



*** User 2024-04-25 16:27:07.069 ***🔗
bOb_subscribe_relog_1464@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2024-04-25 16:27:07.069 ***🔗
bOb_subscribe_relog_1464@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-25 16:27:07.069 ***🔗
bOb_subscribe_relog_1464@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='b35304c8e42aa143' from='localhost' version='1.0' xml:lang='en' to='bob_subscribe_relog_1464@localhost'>

*** User 2024-04-25 16:27:07.070 ***🔗
bOb_subscribe_relog_1464@localhost/res1 in
<stream:features>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-25 16:27:07.070 ***🔗
bOb_subscribe_relog_1464@localhost/res1 out
<iq type='set' id='36f79a0784535241137038ac8ee71381'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2024-04-25 16:27:07.070 ***🔗
bOb_subscribe_relog_1464@localhost/res1 in
<iq id='36f79a0784535241137038ac8ee71381' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>bob_subscribe_relog_1464@localhost/res1</jid>
	</bind>
</iq>



*** User 2024-04-25 16:27:07.070 ***🔗
bob_subscribe_relog_1464@localhost/res1 out
<iq type='set' id='e58975147e0a69b500b4834d34c226d3'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-25 16:27:07.071 ***🔗
bob_subscribe_relog_1464@localhost/res1 in
<iq from='localhost' to='bob_subscribe_relog_1464@localhost/res1' id='e58975147e0a69b500b4834d34c226d3' type='result'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-25 16:27:07.071 ***🔗
bob_subscribe_relog_1464@localhost/res1 out
<presence/>



*** User 2024-04-25 16:27:07.072 ***🔗
bob_subscribe_relog_1464@localhost/res1 in
<presence from='bob_subscribe_relog_1464@localhost/res1' to='bob_subscribe_relog_1464@localhost/res1'/>



*** User 2024-04-25 16:27:07.072 ***🔗
alice_subscribe_relog_1464@localhost/res1 out
<iq type='set' id='8d914bd4c3c9c9f8e4d9f5cde2ff82f4'>
	<query xmlns='jabber:iq:roster'>
		<item jid='bob_subscribe_relog_1464@localhost' name='Bobby'>
			<group>friends</group>
		</item>
	</query>
</iq>



*** User 2024-04-25 16:27:07.073 ***🔗
alice_subscribe_relog_1464@localhost/res1 in
<iq from='alice_subscribe_relog_1464@localhost' to='alice_subscribe_relog_1464@localhost/res1' id='push24f1fbbbb87c77ed' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item name='Bobby' jid='bob_subscribe_relog_1464@localhost' subscription='none'>
			<group>friends</group>
		</item>
	</query>
</iq>



*** User 2024-04-25 16:27:07.073 ***🔗
alice_subscribe_relog_1464@localhost/res1 in
<iq from='alice_subscribe_relog_1464@localhost' to='alice_subscribe_relog_1464@localhost/res1' id='8d914bd4c3c9c9f8e4d9f5cde2ff82f4' type='result'/>



*** User 2024-04-25 16:27:07.073 ***🔗
alice_subscribe_relog_1464@localhost/res1 out
<iq to='alice_subscribe_relog_1464@localhost' id='push24f1fbbbb87c77ed' type='result'/>



*** User 2024-04-25 16:27:07.073 ***🔗
alice_subscribe_relog_1464@localhost/res1 out
<presence type='subscribe' to='bob_subscribe_relog_1464@localhost'/>



*** User 2024-04-25 16:27:07.075 ***🔗
alice_subscribe_relog_1464@localhost/res1 in
<iq from='alice_subscribe_relog_1464@localhost' to='alice_subscribe_relog_1464@localhost/res1' id='pusha16493c812f2a0f4' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item name='Bobby' ask='subscribe' jid='bob_subscribe_relog_1464@localhost' subscription='none'>
			<group>friends</group>
		</item>
	</query>
</iq>



*** User 2024-04-25 16:27:07.075 ***🔗
alice_subscribe_relog_1464@localhost/res1 out
<iq to='alice_subscribe_relog_1464@localhost' id='pusha16493c812f2a0f4' type='result'/>



*** User 2024-04-25 16:27:07.075 ***🔗
bob_subscribe_relog_1464@localhost/res1 in
<presence from='alice_subscribe_relog_1464@localhost' to='bob_subscribe_relog_1464@localhost/res1' type='subscribe'/>



*** User 2024-04-25 16:27:07.076 ***🔗
bOb_subscribe_relog_1464@localhost/newbob out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-25 16:27:07.076 ***🔗
bOb_subscribe_relog_1464@localhost/newbob in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='1a3576e5e172b8c4' from='localhost' version='1.0' xml:lang='en'>

*** User 2024-04-25 16:27:07.076 ***🔗
bOb_subscribe_relog_1464@localhost/newbob in
<stream:features>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
	<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
		<mechanism>PLAIN</mechanism>
	</mechanisms>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-25 16:27:07.076 ***🔗
bOb_subscribe_relog_1464@localhost/newbob out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9zdWJzY3JpYmVfcmVsb2dfMTQ2NABtYWtyb2xpa2E=</auth>



*** User 2024-04-25 16:27:07.078 ***🔗
bOb_subscribe_relog_1464@localhost/newbob in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2024-04-25 16:27:07.078 ***🔗
bOb_subscribe_relog_1464@localhost/newbob out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-25 16:27:07.079 ***🔗
bOb_subscribe_relog_1464@localhost/newbob in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='179209c96e6510d5' from='localhost' version='1.0' xml:lang='en' to='bob_subscribe_relog_1464@localhost'>

*** User 2024-04-25 16:27:07.079 ***🔗
bOb_subscribe_relog_1464@localhost/newbob in
<stream:features>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-25 16:27:07.079 ***🔗
bOb_subscribe_relog_1464@localhost/newbob out
<iq type='set' id='26ba2e3c96d2ab28ed676a0180d1e797'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>newbob</resource>
	</bind>
</iq>



*** User 2024-04-25 16:27:07.079 ***🔗
bOb_subscribe_relog_1464@localhost/newbob in
<iq id='26ba2e3c96d2ab28ed676a0180d1e797' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>bob_subscribe_relog_1464@localhost/newbob</jid>
	</bind>
</iq>



*** User 2024-04-25 16:27:07.079 ***🔗
bob_subscribe_relog_1464@localhost/newbob out
<iq type='set' id='df1a9590f5bce19f7e8c298dd8c824e4'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-25 16:27:07.080 ***🔗
bob_subscribe_relog_1464@localhost/newbob in
<iq from='localhost' to='bob_subscribe_relog_1464@localhost/newbob' id='df1a9590f5bce19f7e8c298dd8c824e4' type='result'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-25 16:27:07.080 ***🔗
bob_subscribe_relog_1464@localhost/newbob out
<presence/>



*** User 2024-04-25 16:27:07.080 ***🔗
bob_subscribe_relog_1464@localhost/res1 in
<presence from='bob_subscribe_relog_1464@localhost/newbob' to='bob_subscribe_relog_1464@localhost/res1'/>



*** User 2024-04-25 16:27:07.080 ***🔗
bob_subscribe_relog_1464@localhost/newbob in
<presence from='alice_subscribe_relog_1464@localhost' to='bob_subscribe_relog_1464@localhost/newbob' type='subscribe'>
	<status/>
</presence>



*** User 2024-04-25 16:27:07.080 ***🔗
bob_subscribe_relog_1464@localhost/newbob in
<presence from='bob_subscribe_relog_1464@localhost/newbob' to='bob_subscribe_relog_1464@localhost/newbob'/>



*** User 2024-04-25 16:27:07.081 ***🔗
bob_subscribe_relog_1464@localhost/newbob in
<presence from='bob_subscribe_relog_1464@localhost/res1' to='bob_subscribe_relog_1464@localhost/newbob'>
	<delay xmlns='urn:xmpp:delay' stamp='2024-04-25T16:27:07.071945Z' from='bob_subscribe_relog_1464@localhost/res1'/>
</presence>



*** User 2024-04-25 16:27:07.081 ***🔗
bob_subscribe_relog_1464@localhost/newbob out
</stream:stream>

*** User 2024-04-25 16:27:07.081 ***🔗
bob_subscribe_relog_1464@localhost/newbob in
</stream:stream>

*** User 2024-04-25 16:27:07.081 ***🔗
bob_subscribe_relog_1464@localhost/res1 out
<presence type='unsubscribed' to='alice_subscribe_relog_1464@localhost'/>



*** User 2024-04-25 16:27:07.081 ***🔗
bob_subscribe_relog_1464@localhost/res1 out
</stream:stream>

*** User 2024-04-25 16:27:07.083 ***🔗
bob_subscribe_relog_1464@localhost/res1 in
</stream:stream>

*** User 2024-04-25 16:27:07.083 ***🔗
alice_subscribe_relog_1464@localhost/res1 out
</stream:stream>

*** User 2024-04-25 16:27:07.083 ***🔗
alice_subscribe_relog_1464@localhost/res1 in
</stream:stream>
*** CT 2024-04-25 16:27:07.091 *** View log from node mongooseim@localhost when finished🔗 mongooseim@localhost_4193.html



=== Ended at 2024-04-25 16:27:07
=== successfully completed test case
=== === Returned value: ok