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

=== Config value:

    [{watchdog,<0.13254.1>},
     {mim_data_dir,"/home/circleci/project/big_tests/tests/presence_SUITE_data"},
     {preset,"riak_mnesia"},
     {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@901bd2a377ee.2022-05-25_10.38.09/big_tests.tests.presence_SUITE.logs/run.2022-05-25_10.49.16/presence_suite.invisible_presence.65666.html"},
     {tc_group_properties,[{name,presence},{repeat_until_all_ok,3},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@901bd2a377ee.2022-05-25_10.38.09/big_tests.tests.presence_SUITE.logs/run.2022-05-25_10.49.16/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@901bd2a377ee.2022-05-25_10.38.09"

=== Started at 2022-05-25 10:49:16
*** CT 2022-05-25 10:49:16.778 *** View log from node mongooseim@localhost when started mongooseim@localhost_4887.html 
*** CT 2022-05-25 10:49:16.781 *** View log from node ejabberd2@localhost when started
ejabberd2@localhost_1997.html






*** User 2022-05-25 10:49:16.804 ***
alicE_invisible_presence_1236@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-05-25 10:49:16.805 ***
alicE_invisible_presence_1236@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='7698a2f30145e9f1' from='localhost' version='1.0' xml:lang='en'>







*** User 2022-05-25 10:49:16.805 ***
alicE_invisible_presence_1236@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-05-25 10:49:16.805 ***
alicE_invisible_presence_1236@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX2ludmlzaWJsZV9wcmVzZW5jZV8xMjM2AG1hdHlncnlzYQ==</auth>









*** User 2022-05-25 10:49:16.808 ***
alicE_invisible_presence_1236@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>









*** User 2022-05-25 10:49:16.808 ***
alicE_invisible_presence_1236@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-05-25 10:49:16.808 ***
alicE_invisible_presence_1236@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='9f24c712fa7b3567' from='localhost' version='1.0' xml:lang='en'>







*** User 2022-05-25 10:49:16.808 ***
alicE_invisible_presence_1236@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-05-25 10:49:16.808 ***
alicE_invisible_presence_1236@localhost/res1 out
<iq type='set' id='e2807fb39c7b710421625340d8f27658'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>









*** User 2022-05-25 10:49:16.809 ***
alicE_invisible_presence_1236@localhost/res1 in
<iq id='e2807fb39c7b710421625340d8f27658' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>alice_invisible_presence_1236@localhost/res1</jid>
	</bind>
</iq>









*** User 2022-05-25 10:49:16.809 ***
alice_invisible_presence_1236@localhost/res1 out
<iq type='set' id='ea10c41b1720b009cbf13f707677a940'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>









*** User 2022-05-25 10:49:16.809 ***
alice_invisible_presence_1236@localhost/res1 in
<iq type='result' id='ea10c41b1720b009cbf13f707677a940'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>









*** User 2022-05-25 10:49:16.809 ***
alice_invisible_presence_1236@localhost/res1 out
<presence/>









*** User 2022-05-25 10:49:16.811 ***
alice_invisible_presence_1236@localhost/res1 in
<presence from='alice_invisible_presence_1236@localhost/res1' to='alice_invisible_presence_1236@localhost/res1' xml:lang='en'/>









*** User 2022-05-25 10:49:16.811 ***
bOb_invisible_presence_1236@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-05-25 10:49:16.812 ***
bOb_invisible_presence_1236@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='f6b2aeee83bfd4d2' from='localhost' version='1.0' xml:lang='en'>







*** User 2022-05-25 10:49:16.812 ***
bOb_invisible_presence_1236@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-05-25 10:49:16.812 ***
bOb_invisible_presence_1236@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9pbnZpc2libGVfcHJlc2VuY2VfMTIzNgBtYWtyb2xpa2E=</auth>









*** User 2022-05-25 10:49:16.876 ***
bOb_invisible_presence_1236@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>









*** User 2022-05-25 10:49:16.876 ***
bOb_invisible_presence_1236@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-05-25 10:49:16.876 ***
bOb_invisible_presence_1236@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='311749db6e48d33f' from='localhost' version='1.0' xml:lang='en'>







*** User 2022-05-25 10:49:16.876 ***
bOb_invisible_presence_1236@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-05-25 10:49:16.876 ***
bOb_invisible_presence_1236@localhost/res1 out
<iq type='set' id='6c0fab33747bb2f770f715302674aaa1'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>









*** User 2022-05-25 10:49:16.876 ***
bOb_invisible_presence_1236@localhost/res1 in
<iq id='6c0fab33747bb2f770f715302674aaa1' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>bob_invisible_presence_1236@localhost/res1</jid>
	</bind>
</iq>









*** User 2022-05-25 10:49:16.876 ***
bob_invisible_presence_1236@localhost/res1 out
<iq type='set' id='0b1e826ffa69c5e5397e4ce63dfe5d0e'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>









*** User 2022-05-25 10:49:16.877 ***
bob_invisible_presence_1236@localhost/res1 in
<iq type='result' id='0b1e826ffa69c5e5397e4ce63dfe5d0e'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>









*** User 2022-05-25 10:49:16.877 ***
bob_invisible_presence_1236@localhost/res1 out
<presence/>









*** User 2022-05-25 10:49:16.878 ***
bob_invisible_presence_1236@localhost/res1 in
<presence from='bob_invisible_presence_1236@localhost/res1' to='bob_invisible_presence_1236@localhost/res1' xml:lang='en'/>









*** User 2022-05-25 10:49:16.878 ***
alice_invisible_presence_1236@localhost/res1 out
<iq type='set' id='5d2f35fe0c58b7c37e8d338a7aec1882'>
	<query xmlns='jabber:iq:roster'>
		<item jid='bob_invisible_presence_1236@localhost' name='Bobby'>
			<group>friends</group>
		</item>
	</query>
</iq>









*** User 2022-05-25 10:49:16.881 ***
alice_invisible_presence_1236@localhost/res1 in
<iq from='alice_invisible_presence_1236@localhost' to='alice_invisible_presence_1236@localhost/res1' id='push3e7ece0cdb58932d' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='none' name='Bobby' jid='bob_invisible_presence_1236@localhost'>
			<group>friends</group>
		</item>
	</query>
</iq>









*** User 2022-05-25 10:49:16.881 ***
alice_invisible_presence_1236@localhost/res1 in
<iq from='alice_invisible_presence_1236@localhost' to='alice_invisible_presence_1236@localhost/res1' id='5d2f35fe0c58b7c37e8d338a7aec1882' type='result'/>









*** User 2022-05-25 10:49:16.881 ***
alice_invisible_presence_1236@localhost/res1 out
<iq to='alice_invisible_presence_1236@localhost' id='push3e7ece0cdb58932d' type='result'/>









*** User 2022-05-25 10:49:16.881 ***
alice_invisible_presence_1236@localhost/res1 out
<presence type='subscribe' to='bob_invisible_presence_1236@localhost'/>









*** User 2022-05-25 10:49:16.886 ***
alice_invisible_presence_1236@localhost/res1 in
<iq from='alice_invisible_presence_1236@localhost' to='alice_invisible_presence_1236@localhost/res1' id='pushf5cda92285b45ab7' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item ask='subscribe' subscription='none' name='Bobby' jid='bob_invisible_presence_1236@localhost'>
			<group>friends</group>
		</item>
	</query>
</iq>









*** User 2022-05-25 10:49:16.886 ***
alice_invisible_presence_1236@localhost/res1 out
<iq to='alice_invisible_presence_1236@localhost' id='pushf5cda92285b45ab7' type='result'/>









*** User 2022-05-25 10:49:16.886 ***
bob_invisible_presence_1236@localhost/res1 in
<presence from='alice_invisible_presence_1236@localhost' to='bob_invisible_presence_1236@localhost/res1' xml:lang='en' type='subscribe'/>









*** User 2022-05-25 10:49:16.886 ***
bob_invisible_presence_1236@localhost/res1 out
<iq type='set' id='4ca5f829ca3c9eb773a2397a5042e7b6'>
	<query xmlns='jabber:iq:roster'>
		<item jid='alice_invisible_presence_1236@localhost' name='Alice'>
			<group>enemies</group>
		</item>
	</query>
</iq>









*** User 2022-05-25 10:49:16.889 ***
bob_invisible_presence_1236@localhost/res1 in
<iq from='bob_invisible_presence_1236@localhost' to='bob_invisible_presence_1236@localhost/res1' id='push12f89c1324a64151' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='none' name='Alice' jid='alice_invisible_presence_1236@localhost'>
			<group>enemies</group>
		</item>
	</query>
</iq>









*** User 2022-05-25 10:49:16.889 ***
bob_invisible_presence_1236@localhost/res1 out
<iq to='bob_invisible_presence_1236@localhost' id='push12f89c1324a64151' type='result'/>









*** User 2022-05-25 10:49:16.889 ***
bob_invisible_presence_1236@localhost/res1 in
<iq from='bob_invisible_presence_1236@localhost' to='bob_invisible_presence_1236@localhost/res1' id='4ca5f829ca3c9eb773a2397a5042e7b6' type='result'/>









*** User 2022-05-25 10:49:16.889 ***
bob_invisible_presence_1236@localhost/res1 out
<presence type='subscribed' to='alice_invisible_presence_1236@localhost'/>









*** User 2022-05-25 10:49:16.894 ***
alice_invisible_presence_1236@localhost/res1 in
<iq from='alice_invisible_presence_1236@localhost' to='alice_invisible_presence_1236@localhost/res1' id='push12927dac080a8c81' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='to' name='Bobby' jid='bob_invisible_presence_1236@localhost'>
			<group>friends</group>
		</item>
	</query>
</iq>









*** User 2022-05-25 10:49:16.894 ***
alice_invisible_presence_1236@localhost/res1 in
<presence from='bob_invisible_presence_1236@localhost' to='alice_invisible_presence_1236@localhost/res1' xml:lang='en' type='subscribed'/>









*** User 2022-05-25 10:49:16.895 ***
alice_invisible_presence_1236@localhost/res1 in
<presence from='bob_invisible_presence_1236@localhost/res1' to='alice_invisible_presence_1236@localhost/res1' xml:lang='en'/>









*** User 2022-05-25 10:49:16.895 ***
bob_invisible_presence_1236@localhost/res1 in
<iq from='bob_invisible_presence_1236@localhost' to='bob_invisible_presence_1236@localhost/res1' id='push3808f59c497119be' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='from' name='Alice' jid='alice_invisible_presence_1236@localhost'>
			<group>enemies</group>
		</item>
	</query>
</iq>









*** User 2022-05-25 10:49:16.895 ***
bob_invisible_presence_1236@localhost/res1 out
<presence/>









*** User 2022-05-25 10:49:16.900 ***
alice_invisible_presence_1236@localhost/res1 in
<presence from='bob_invisible_presence_1236@localhost/res1' to='alice_invisible_presence_1236@localhost/res1' xml:lang='en'/>









*** User 2022-05-25 10:49:16.900 ***
bob_invisible_presence_1236@localhost/res1 out
<presence type='invisible'/>









*** User 2022-05-25 10:49:16.901 ***
alice_invisible_presence_1236@localhost/res1 in
<presence from='bob_invisible_presence_1236@localhost/res1' to='alice_invisible_presence_1236@localhost/res1' type='unavailable' xml:lang='en'/>









*** User 2022-05-25 10:49:16.901 ***
bob_invisible_presence_1236@localhost/res1 out
<presence/>









*** User 2022-05-25 10:49:16.902 ***
alice_invisible_presence_1236@localhost/res1 in
<presence from='bob_invisible_presence_1236@localhost/res1' to='alice_invisible_presence_1236@localhost/res1' xml:lang='en'/>









*** User 2022-05-25 10:49:16.903 ***
bob_invisible_presence_1236@localhost/res1 out
</stream:stream>







*** User 2022-05-25 10:49:16.903 ***
bob_invisible_presence_1236@localhost/res1 in
</stream:stream>







*** User 2022-05-25 10:49:16.903 ***
alice_invisible_presence_1236@localhost/res1 out
</stream:stream>







*** User 2022-05-25 10:49:16.903 ***
alice_invisible_presence_1236@localhost/res1 in
</stream:stream>



*** CT 2022-05-25 10:49:16.914 *** View log from node ejabberd2@localhost when finished
ejabberd2@localhost_1997.html


*** CT 2022-05-25 10:49:16.915 *** View log from node mongooseim@localhost when finished
mongooseim@localhost_4888.html





=== Ended at 2022-05-25 10:49:16
=== successfully completed test case
=== === Returned value: ok