=== Test case: mam_SUITE:messages_filtered_when_prefs_default_policy_is_roster/1 (click for source code)

=== Config value:

    [{basic_group,prefs_cases},
     {configuration,rdbms_mnesia_cache},
     {watchdog,<0.8421.1>},
     {mod_offline_loaded,false},
     {escalus_user_db,{module,escalus_ejabberd}},
     {mim_data_dir,"/home/circleci/project/big_tests/tests/mam_SUITE_data"},
     {preset,"odbc_mssql_mnesia"},
     {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@998557c7e1d1.2022-01-27_12.27.57/big_tests.tests.mam_SUITE.logs/run.2022-01-27_12.31.28/mam_suite.messages_filtered_when_prefs_default_policy_is_roster.84867.html"},
     {tc_group_properties,[{name,rdbms_mnesia_cache_prefs_cases},parallel]},
     {tc_group_path,[]},
     {data_dir,"/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/mam_SUITE_data/"},
     {priv_dir,"/home/circleci/project/big_tests/ct_report/ct_run.test@998557c7e1d1.2022-01-27_12.27.57/big_tests.tests.mam_SUITE.logs/run.2022-01-27_12.31.28/log_private/"},
     {config_backup,#{[shaper,fast] => {ok,#{max_rate => 50000}},
                      [shaper,mam_shaper] => {ok,#{max_rate => 1}},
                      [shaper,normal] => {ok,#{max_rate => 1000}},
                      [{access,<<"test type">>},max_user_sessions] =>
                          {ok,[#{acl => all,value => 10}]}}},
     {{saved_modules,mongooseim@localhost,<<"test type">>},
      #{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_mam => [{archive_groupchats,false}],
        mod_mam_cache_user => [{pm,true}],
        mod_mam_mnesia_prefs => [{pm,true}],
        mod_mam_rdbms_arch => [],
        mod_mam_rdbms_user => [{pm,true}],
        mod_muc =>
            [{host,{prefix,<<"groupchats.">>}},
             {backend,rdbms},
             {hibernate_timeout,2000},
             {hibernated_room_check_interval,1000},
             {hibernated_room_timeout,2000},
             {access,muc},
             {access_create,muc_create}],
        mod_muc_commands => [],mod_muc_light_commands => [],
        mod_muc_log => [{outdir,"/tmp/muclogs"},{access_log,muc}],
        mod_register =>
            [{access,register},
             {ip_access,[{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]},
             {welcome_message,{[],[]}}],
        mod_roster => [{backend,rdbms}],
        mod_sic => [],mod_stream_management => [],
        mod_vcard => [{backend,rdbms},{host,{prefix,<<"vjud.">>}}]}},
     {escalus_users,[{alice,[{username,<<"alicE">>},
                             {server,<<"domain.example.com">>},
                             {host,<<"localhost">>},
                             {password,<<"matygrysa">>}]},
                     {bob,[{username,<<"bOb">>},
                           {server,<<"domain.example.com">>},
                           {host,<<"localhost">>},
                           {password,<<"makrolika">>}]},
                     {kate,[{username,<<"kate">>},
                            {server,<<"domain.example.com">>},
                            {host,<<"localhost">>},
                            {password,<<"makrowe;p">>}]},
                     {carol,[{username,<<"carol">>},
                             {server,<<"domain.example.com">>},
                             {host,<<"localhost">>},
                             {password,<<"jinglebells">>},
                             {transport,escalus_bosh},
                             {path,<<"/http-bind">>},
                             {port,5280}]}]}]

=== Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@998557c7e1d1.2022-01-27_12.27.57"

=== Started at 2022-01-27 12:32:38


*** CT 2022-01-27 12:32:38.069 *** View log from node mongooseim@localhost when started mongooseim@localhost_1816.html
*** CT 2022-01-27 12:32:38.071 *** View log from node ejabberd2@localhost when started ejabberd2@localhost_538.html
Could not find element props in Config.


*** User 2022-01-27 12:32:38.120 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.120 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='5ab6f5f12b249602' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-01-27 12:32:38.120 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.120 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX21lc3NhZ2VzX2ZpbHRlcmVkX3doZW5fcHJlZnNfZGVmYXVsdF9wb2xpY3lfaXNfcm9zdGVyXzE0MDEAbWF0eWdyeXNh</auth>



*** User 2022-01-27 12:32:38.122 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-01-27 12:32:38.122 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.122 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='c458e0beabb9bad2' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-01-27 12:32:38.122 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.123 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='92d15554b60456cc2e5c63b9bf4c8447'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-01-27 12:32:38.123 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq id='92d15554b60456cc2e5c63b9bf4c8447' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-01-27 12:32:38.123 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='d167c67fa24464455802738e9b08ac27'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-01-27 12:32:38.123 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq type='result' id='d167c67fa24464455802738e9b08ac27'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-01-27 12:32:38.123 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<presence/>



*** User 2022-01-27 12:32:38.134 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en'/>



*** User 2022-01-27 12:32:38.135 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.135 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='bfc353c37792b3e1' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-01-27 12:32:38.135 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.136 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9tZXNzYWdlc19maWx0ZXJlZF93aGVuX3ByZWZzX2RlZmF1bHRfcG9saWN5X2lzX3Jvc3Rlcl8xNDAxAG1ha3JvbGlrYQ==</auth>



*** User 2022-01-27 12:32:38.137 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-01-27 12:32:38.137 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.137 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='4d6d732fcc193c8d' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-01-27 12:32:38.137 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.137 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='ccd9b1a0f56f3e752315f4c6fd02f84a'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-01-27 12:32:38.137 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq id='ccd9b1a0f56f3e752315f4c6fd02f84a' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-01-27 12:32:38.137 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='10a78ba767181bdf596939458b2b7a2c'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-01-27 12:32:38.138 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq type='result' id='10a78ba767181bdf596939458b2b7a2c'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-01-27 12:32:38.138 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<presence/>



*** User 2022-01-27 12:32:38.140 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en'/>



*** User 2022-01-27 12:32:38.140 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.140 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='462448cd7b99ddec' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-01-27 12:32:38.141 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.141 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGthdGVfbWVzc2FnZXNfZmlsdGVyZWRfd2hlbl9wcmVmc19kZWZhdWx0X3BvbGljeV9pc19yb3N0ZXJfMTQwMQBtYWtyb3dlO3A=</auth>



*** User 2022-01-27 12:32:38.142 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-01-27 12:32:38.142 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.142 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='feceff09a3a4a081' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-01-27 12:32:38.142 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@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-01-27 12:32:38.142 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='60213fdabef782cc9fc66c20800f461e'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-01-27 12:32:38.143 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq id='60213fdabef782cc9fc66c20800f461e' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-01-27 12:32:38.143 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='f12a730fdd90152cd76ca72fe211bd92'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-01-27 12:32:38.143 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq type='result' id='f12a730fdd90152cd76ca72fe211bd92'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-01-27 12:32:38.143 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<presence/>



*** User 2022-01-27 12:32:38.145 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<presence from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en'/>



*** User 2022-01-27 12:32:38.145 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<presence type='subscribe' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>



*** User 2022-01-27 12:32:38.198 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='push11afc5eceac367a4' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item ask='subscribe' subscription='none' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>
	</query>
</iq>



*** User 2022-01-27 12:32:38.198 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='subscribe'/>



*** User 2022-01-27 12:32:38.198 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<presence type='subscribed' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>



*** User 2022-01-27 12:32:38.229 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='push67db2ea0a4dc201a' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>
	</query>
</iq>



*** User 2022-01-27 12:32:38.229 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='subscribed'/>



*** User 2022-01-27 12:32:38.229 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en'/>



*** User 2022-01-27 12:32:38.230 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='pushf9391cdc2d0fe498' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>
	</query>
</iq>



*** User 2022-01-27 12:32:38.230 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<presence type='subscribe' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>



*** User 2022-01-27 12:32:38.266 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='push1845de699bf78601' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>
	</query>
</iq>



*** User 2022-01-27 12:32:38.266 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='subscribe'/>



*** User 2022-01-27 12:32:38.266 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='push93e33192ec31aab0' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item ask='subscribe' subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>
	</query>
</iq>



*** User 2022-01-27 12:32:38.266 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<presence type='subscribed' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>



*** User 2022-01-27 12:32:38.280 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='push0c3acfb86ecf5376' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='both' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>
	</query>
</iq>



*** User 2022-01-27 12:32:38.280 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='pusha40ddc9e110cbb9a' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='both' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com'/>
	</query>
</iq>



*** User 2022-01-27 12:32:38.280 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='subscribed'/>



*** User 2022-01-27 12:32:38.280 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en'/>



*** User 2022-01-27 12:32:38.280 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='39e98736e594eb8bdd3a6ed53adf324e'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never/>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.299 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='39e98736e594eb8bdd3a6ed53adf324e' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never/>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.299 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[]}, now={1643,286758,299781}</body>
</message>



*** User 2022-01-27 12:32:38.299 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[]}, now={1643,286758,299796}</body>
</message>



*** User 2022-01-27 12:32:38.300 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[]}, now={1643,286758,299803}</body>
</message>



*** User 2022-01-27 12:32:38.300 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[]}, now={1643,286758,299810}</body>
</message>



*** User 2022-01-27 12:32:38.368 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[]}, now={1643,286758,299796}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGDV1KFO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.368 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[]}, now={1643,286758,299810}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGDVBTOG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.368 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[]}, now={1643,286758,299803}</body>
</message>



*** User 2022-01-27 12:32:38.368 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[]}, now={1643,286758,299781}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGDVBVS81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.368 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='a7343a23e4b0649251c6485a075fec24'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.369 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='a7343a23e4b0649251c6485a075fec24' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.369 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[bob],[]}, now={1643,286758,369868}</body>
</message>



*** User 2022-01-27 12:32:38.370 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[bob],[]}, now={1643,286758,369883}</body>
</message>



*** User 2022-01-27 12:32:38.370 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[bob],[]}, now={1643,286758,369891}</body>
</message>



*** User 2022-01-27 12:32:38.370 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[bob],[]}, now={1643,286758,369899}</body>
</message>



*** User 2022-01-27 12:32:38.389 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[bob],[]}, now={1643,286758,369883}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGDVJK3G1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.394 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[bob],[]}, now={1643,286758,369899}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGDVNCGG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.394 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[bob],[]}, now={1643,286758,369868}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGDVINQG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.394 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[bob],[]}, now={1643,286758,369891}</body>
</message>



*** User 2022-01-27 12:32:38.394 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='a7cca2423b4f770f6ba4a03af3c73732'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.395 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='a7cca2423b4f770f6ba4a03af3c73732' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.395 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[kate],[]}, now={1643,286758,395438}</body>
</message>



*** User 2022-01-27 12:32:38.395 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[kate],[]}, now={1643,286758,395449}</body>
</message>



*** User 2022-01-27 12:32:38.395 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[kate],[]}, now={1643,286758,395454}</body>
</message>



*** User 2022-01-27 12:32:38.395 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[kate],[]}, now={1643,286758,395458}</body>
</message>



*** User 2022-01-27 12:32:38.481 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[kate],[]}, now={1643,286758,395449}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGDVRJQ01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.482 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[kate],[]}, now={1643,286758,395458}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE047A81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.482 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[kate],[]}, now={1643,286758,395454}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGDVRJPG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.482 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[kate],[]}, now={1643,286758,395438}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE047AG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.482 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='98d76b9e942eb57e4f5c31e340ad5e61'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.483 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='98d76b9e942eb57e4f5c31e340ad5e61' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.483 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[kate,bob],[]}, now={1643,286758,483152}</body>
</message>



*** User 2022-01-27 12:32:38.483 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[kate,bob],[]}, now={1643,286758,483163}</body>
</message>



*** User 2022-01-27 12:32:38.483 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[kate,bob],[]}, now={1643,286758,483168}</body>
</message>



*** User 2022-01-27 12:32:38.483 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[kate,bob],[]}, now={1643,286758,483173}</body>
</message>



*** User 2022-01-27 12:32:38.540 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[kate,bob],[]}, now={1643,286758,483163}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE0FO481' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.567 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[kate,bob],[]}, now={1643,286758,483173}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE0S6UG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.567 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[kate,bob],[]}, now={1643,286758,483152}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE0FO401' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.567 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[kate,bob],[]}, now={1643,286758,483168}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE0FO4G1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.568 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='4e1e9ea97628f0a8825010e0b3958823'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.569 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='4e1e9ea97628f0a8825010e0b3958823' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.569 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[bob]}, now={1643,286758,569169}</body>
</message>



*** User 2022-01-27 12:32:38.569 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[bob]}, now={1643,286758,569179}</body>
</message>



*** User 2022-01-27 12:32:38.569 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[bob]}, now={1643,286758,569184}</body>
</message>



*** User 2022-01-27 12:32:38.569 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[bob]}, now={1643,286758,569189}</body>
</message>



*** User 2022-01-27 12:32:38.596 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[bob]}, now={1643,286758,569179}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE13BU01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.598 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[bob]}, now={1643,286758,569189}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE19DI01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.598 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[bob]}, now={1643,286758,569169}</body>
</message>



*** User 2022-01-27 12:32:38.598 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[bob]}, now={1643,286758,569184}</body>
</message>



*** User 2022-01-27 12:32:38.598 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='53ed76d3261424ad2d8e6fe2c47c5315'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.599 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='53ed76d3261424ad2d8e6fe2c47c5315' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.599 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[kate]}, now={1643,286758,599783}</body>
</message>



*** User 2022-01-27 12:32:38.599 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[kate]}, now={1643,286758,599795}</body>
</message>



*** User 2022-01-27 12:32:38.599 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[kate]}, now={1643,286758,599800}</body>
</message>



*** User 2022-01-27 12:32:38.599 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[kate]}, now={1643,286758,599804}</body>
</message>



*** User 2022-01-27 12:32:38.619 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[kate]}, now={1643,286758,599795}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE1B4S81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.628 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[kate]}, now={1643,286758,599804}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE1FHF01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.628 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[kate]}, now={1643,286758,599800}</body>
</message>



*** User 2022-01-27 12:32:38.628 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[kate]}, now={1643,286758,599783}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE1E3581' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.629 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='f7f6504ed1679119ea67980800b27139'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.629 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='f7f6504ed1679119ea67980800b27139' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-01-27 12:32:38.630 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[bob,kate]}, now={1643,286758,630042}</body>
</message>



*** User 2022-01-27 12:32:38.630 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[bob,kate]}, now={1643,286758,630053}</body>
</message>



*** User 2022-01-27 12:32:38.630 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[bob,kate]}, now={1643,286758,630059}</body>
</message>



*** User 2022-01-27 12:32:38.630 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[bob,kate]}, now={1643,286758,630063}</body>
</message>



*** User 2022-01-27 12:32:38.631 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[bob,kate]}, now={1643,286758,630053}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE1I8C01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.634 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[bob,kate]}, now={1643,286758,630063}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' id='BLKFGE1IIG01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-01-27 12:32:38.634 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[bob,kate]}, now={1643,286758,630042}</body>
</message>


Could not find element wait_for_parallel_writer in Config.

Could not find element archive_wait in Config.


*** User 2022-01-27 12:32:38.634 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[bob,kate]}, now={1643,286758,630059}</body>
</message>



*** User 2022-01-27 12:32:38.634 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='fe908f8d33c9168b81e4747a7898e012'>
	<query xmlns='urn:xmpp:mam:1' queryid='page_rsm'>
		<x xmlns='jabber:x:data'/>
		<set>
			<max>50</max>
			<after/>
		</set>
	</query>
</iq>



*** User 2022-01-27 12:32:38.637 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='8ba8702e-2407-42fe-a5e3-41308538c100'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGDV1JUG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[],[]}, now={1643,286758,299796}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.637 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='0247603c-6b34-468c-9ec5-a4134f130b19'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGDVBVS81'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[],[]}, now={1643,286758,299781}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.637 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='9e16fe19-2c3a-4480-8ef8-033092eaf784'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGDVINQ01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[bob],[]}, now={1643,286758,369883}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.637 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='412af70b-d754-40e8-ac9c-1fba6501a80b'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGDVINQG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[bob],[]}, now={1643,286758,369868}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='435ab93f-ab29-42ff-ae7b-be64970f5078'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGDVR5P01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[kate],[]}, now={1643,286758,395449}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='436dcb32-c397-425d-a5de-42760a89b55b'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGDVRJPG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=3, prefs={roster,[kate],[]}, now={1643,286758,395454}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='4dce647f-fc6b-4d51-8084-1a7b44bd0df4'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGE0479O1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=4, prefs={roster,[kate],[]}, now={1643,286758,395458}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='10d6be32-05b3-4f62-8fc3-808f14a40e7b'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGE047AG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[kate],[]}, now={1643,286758,395438}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='3ba9ebb1-74f8-4f11-9a1e-82a28136db24'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGE0EBOO1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[kate,bob],[]}, now={1643,286758,483163}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='6dec4c11-441c-4fc7-9263-a796719d5876'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGE0FO401'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[kate,bob],[]}, now={1643,286758,483152}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='3cb01034-9dd0-4662-a47a-a99d2aaa83f6'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGE0FO4G1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=3, prefs={roster,[kate,bob],[]}, now={1643,286758,483168}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='00510e9f-257c-40ee-aa38-c2713ee0fe79'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGE0S6TG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=4, prefs={roster,[kate,bob],[]}, now={1643,286758,483173}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='e89ed2dc-6d11-4618-acd6-f0f0f345a730'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGE1B4S01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[],[kate]}, now={1643,286758,599795}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='c726bad6-2180-445e-98e6-b1aaddcb266b'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFGE1E3581'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:38Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[],[kate]}, now={1643,286758,599783}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='fe908f8d33c9168b81e4747a7898e012' type='result'>
	<fin xmlns='urn:xmpp:mam:1' complete='true'>
		<set xmlns='http://jabber.org/protocol/rsm'>
			<first index='0'>BLKFGDV1JUG1</first>
			<last>BLKFGE1E3581</last>
			<count>14</count>
		</set>
	</fin>
</iq>



*** User 2022-01-27 12:32:38.638 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
<iq type='set' id='5a54a69cb25a8bd9fd59b7f621d5f5bd'>
	<query xmlns='urn:xmpp:mam:1' queryid='page_rsm'>
		<x xmlns='jabber:x:data'/>
		<set>
			<max>50</max>
			<after>BLKFGE1E3581</after>
		</set>
	</query>
</iq>



*** User 2022-01-27 12:32:38.641 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1' id='5a54a69cb25a8bd9fd59b7f621d5f5bd' type='result'>
	<fin xmlns='urn:xmpp:mam:1' complete='true'>
		<set xmlns='http://jabber.org/protocol/rsm'>
			<count>14</count>
		</set>
	</fin>
</iq>



*** User 2022-01-27 12:32:38.641 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
</stream:stream>

*** User 2022-01-27 12:32:38.641 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
</stream:stream>

*** User 2022-01-27 12:32:38.641 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
</stream:stream>

*** User 2022-01-27 12:32:38.641 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
</stream:stream>

*** User 2022-01-27 12:32:38.641 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 out
</stream:stream>

*** User 2022-01-27 12:32:38.642 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1401@domain.example.com/res1 in
</stream:stream>
*** CT 2022-01-27 12:32:38.648 *** View log from node ejabberd2@localhost when finished ejabberd2@localhost_538.html
*** CT 2022-01-27 12:32:38.649 *** View log from node mongooseim@localhost when finished mongooseim@localhost_1818.html



=== Ended at 2022-01-27 12:32:38
=== successfully completed test case
=== === Returned value: ok