=== 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_simple},
     {watchdog,<0.27434.0>},
     {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@88d84ff17c71.2022-03-04_11.16.52/big_tests.tests.mam_SUITE.logs/run.2022-03-04_11.20.29/mam_suite.messages_filtered_when_prefs_default_policy_is_roster.36739.html"},
     {tc_group_properties,[{name,rdbms_simple_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@88d84ff17c71.2022-03-04_11.16.52/big_tests.tests.mam_SUITE.logs/run.2022-03-04_11.20.29/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_rdbms_arch =>
            [[{db_jid_format,mam_jid_rfc},
              {db_message_format,mam_message_xml}]],
        mod_mam_rdbms_prefs => [{pm,true}],
        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@88d84ff17c71.2022-03-04_11.16.52"

=== Started at 2022-03-04 11:20:45


*** CT 2022-03-04 11:20:45.978 *** View log from node mongooseim@localhost when started mongooseim@localhost_992.html
*** CT 2022-03-04 11:20:45.979 *** View log from node ejabberd2@localhost when started ejabberd2@localhost_529.html
Could not find element props in Config.


*** User 2022-03-04 11:20:46.031 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.032 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3ef438a302a337da' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-03-04 11:20:46.032 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.032 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX21lc3NhZ2VzX2ZpbHRlcmVkX3doZW5fcHJlZnNfZGVmYXVsdF9wb2xpY3lfaXNfcm9zdGVyXzEwMzEAbWF0eWdyeXNh</auth>



*** User 2022-03-04 11:20:46.034 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-03-04 11:20:46.034 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.034 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='04ccc2318a286335' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-03-04 11:20:46.034 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.034 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='dd2fa28bd7594448d80ff65644f65e0d'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-03-04 11:20:46.035 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq id='dd2fa28bd7594448d80ff65644f65e0d' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-03-04 11:20:46.035 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='f318b9e2712aac35f7a1f59a48057cba'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-03-04 11:20:46.035 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq type='result' id='f318b9e2712aac35f7a1f59a48057cba'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-03-04 11:20:46.035 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<presence/>



*** User 2022-03-04 11:20:46.041 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en'/>



*** User 2022-03-04 11:20:46.042 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.042 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='999b8fdd38ea0d45' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-03-04 11:20:46.042 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.043 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9tZXNzYWdlc19maWx0ZXJlZF93aGVuX3ByZWZzX2RlZmF1bHRfcG9saWN5X2lzX3Jvc3Rlcl8xMDMxAG1ha3JvbGlrYQ==</auth>



*** User 2022-03-04 11:20:46.044 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-03-04 11:20:46.044 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.044 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='dd41048c0596bfe1' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-03-04 11:20:46.044 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.044 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='dd41f41f782f78abbafe7fe19a6ac99d'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-03-04 11:20:46.045 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq id='dd41f41f782f78abbafe7fe19a6ac99d' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-03-04 11:20:46.045 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='1e95ae7238831035fd35b3dfd332fc6f'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-03-04 11:20:46.045 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq type='result' id='1e95ae7238831035fd35b3dfd332fc6f'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-03-04 11:20:46.046 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<presence/>



*** User 2022-03-04 11:20:46.047 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en'/>



*** User 2022-03-04 11:20:46.048 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.048 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='e043e900dc616a98' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-03-04 11:20:46.048 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.049 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGthdGVfbWVzc2FnZXNfZmlsdGVyZWRfd2hlbl9wcmVmc19kZWZhdWx0X3BvbGljeV9pc19yb3N0ZXJfMTAzMQBtYWtyb3dlO3A=</auth>



*** User 2022-03-04 11:20:46.050 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-03-04 11:20:46.050 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.050 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3e724a77e8131953' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-03-04 11:20:46.050 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@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-03-04 11:20:46.050 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='a39b46f921e7a32016845dd47f79a595'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-03-04 11:20:46.051 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq id='a39b46f921e7a32016845dd47f79a595' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-03-04 11:20:46.051 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='d542b6f2d8406af77060bbc313dde3be'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-03-04 11:20:46.051 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq type='result' id='d542b6f2d8406af77060bbc313dde3be'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-03-04 11:20:46.051 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<presence/>



*** User 2022-03-04 11:20:46.054 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<presence from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en'/>



*** User 2022-03-04 11:20:46.054 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<presence type='subscribe' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>



*** User 2022-03-04 11:20:46.074 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='push60876553aec0cf0e' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item ask='subscribe' subscription='none' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>
	</query>
</iq>



*** User 2022-03-04 11:20:46.074 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='subscribe'/>



*** User 2022-03-04 11:20:46.074 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<presence type='subscribed' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>



*** User 2022-03-04 11:20:46.079 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='push6319490c02341c76' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>
	</query>
</iq>



*** User 2022-03-04 11:20:46.079 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='subscribed'/>



*** User 2022-03-04 11:20:46.079 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en'/>



*** User 2022-03-04 11:20:46.079 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='pushdf1f2956b34b25f3' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>
	</query>
</iq>



*** User 2022-03-04 11:20:46.080 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<presence type='subscribe' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>



*** User 2022-03-04 11:20:46.090 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='push61bf11f15e83bd1d' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>
	</query>
</iq>



*** User 2022-03-04 11:20:46.090 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='subscribe'/>



*** User 2022-03-04 11:20:46.091 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='push6a416c6f8bb150d6' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item ask='subscribe' subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>
	</query>
</iq>



*** User 2022-03-04 11:20:46.091 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<presence type='subscribed' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>



*** User 2022-03-04 11:20:46.099 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='pushf888bf9928bad3b3' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='both' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>
	</query>
</iq>



*** User 2022-03-04 11:20:46.099 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='push9be341e0eecb0314' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='both' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com'/>
	</query>
</iq>



*** User 2022-03-04 11:20:46.099 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='subscribed'/>



*** User 2022-03-04 11:20:46.099 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en'/>



*** User 2022-03-04 11:20:46.099 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='b4fc732a8c7d8834aaa6e2094a16fefa'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never/>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.147 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='b4fc732a8c7d8834aaa6e2094a16fefa' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never/>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.147 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[]}, now={1646,392846,147200}</body>
</message>



*** User 2022-03-04 11:20:46.147 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[]}, now={1646,392846,147216}</body>
</message>



*** User 2022-03-04 11:20:46.147 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[]}, now={1646,392846,147223}</body>
</message>



*** User 2022-03-04 11:20:46.147 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[]}, now={1646,392846,147255}</body>
</message>



*** User 2022-03-04 11:20:46.162 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[]}, now={1646,392846,147216}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ0N10O1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.168 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[]}, now={1646,392846,147255}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ0PBDG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.168 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[]}, now={1646,392846,147200}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ0N1181' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.168 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[]}, now={1646,392846,147223}</body>
</message>



*** User 2022-03-04 11:20:46.168 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='0929f6373ece282e0c19962863c665f8'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.188 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='0929f6373ece282e0c19962863c665f8' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.188 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[bob],[]}, now={1646,392846,188224}</body>
</message>



*** User 2022-03-04 11:20:46.188 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[bob],[]}, now={1646,392846,188235}</body>
</message>



*** User 2022-03-04 11:20:46.188 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[bob],[]}, now={1646,392846,188241}</body>
</message>



*** User 2022-03-04 11:20:46.188 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[bob],[]}, now={1646,392846,188246}</body>
</message>



*** User 2022-03-04 11:20:46.198 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[bob],[]}, now={1646,392846,188235}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ10F281' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.242 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[bob],[]}, now={1646,392846,188246}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ12CDO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.242 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[bob],[]}, now={1646,392846,188241}</body>
</message>



*** User 2022-03-04 11:20:46.242 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[bob],[]}, now={1646,392846,188224}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ10F2O1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.242 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='41e3eaee87523c049d1e186daabcfd46'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.249 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='41e3eaee87523c049d1e186daabcfd46' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.249 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[kate],[]}, now={1646,392846,249567}</body>
</message>



*** User 2022-03-04 11:20:46.249 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[kate],[]}, now={1646,392846,249578}</body>
</message>



*** User 2022-03-04 11:20:46.249 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[kate],[]}, now={1646,392846,249583}</body>
</message>



*** User 2022-03-04 11:20:46.249 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[kate],[]}, now={1646,392846,249587}</body>
</message>



*** User 2022-03-04 11:20:46.259 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[kate],[]}, now={1646,392846,249578}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ1FCLG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.270 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[kate],[]}, now={1646,392846,249587}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ1IUT01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.270 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[kate],[]}, now={1646,392846,249567}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ1FCL01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.270 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[kate],[]}, now={1646,392846,249583}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ1FCL81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.270 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='14903b9f8c6e8dee478e33b75961be70'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.275 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='14903b9f8c6e8dee478e33b75961be70' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.275 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[kate,bob],[]}, now={1646,392846,275196}</body>
</message>



*** User 2022-03-04 11:20:46.275 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[kate,bob],[]}, now={1646,392846,275208}</body>
</message>



*** User 2022-03-04 11:20:46.275 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[kate,bob],[]}, now={1646,392846,275213}</body>
</message>



*** User 2022-03-04 11:20:46.275 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[kate,bob],[]}, now={1646,392846,275218}</body>
</message>



*** User 2022-03-04 11:20:46.285 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[kate,bob],[]}, now={1646,392846,275208}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ1L7881' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.339 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[kate,bob],[]}, now={1646,392846,275218}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ1O8R81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.339 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[kate,bob],[]}, now={1646,392846,275196}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ1L78G1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.339 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[kate,bob],[]}, now={1646,392846,275213}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ1L78O1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.339 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='16edc8950a35d208b9646904aae9031a'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.345 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='16edc8950a35d208b9646904aae9031a' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.345 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[bob]}, now={1646,392846,345280}</body>
</message>



*** User 2022-03-04 11:20:46.345 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[bob]}, now={1646,392846,345292}</body>
</message>



*** User 2022-03-04 11:20:46.345 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[bob]}, now={1646,392846,345300}</body>
</message>



*** User 2022-03-04 11:20:46.345 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[bob]}, now={1646,392846,345330}</body>
</message>



*** User 2022-03-04 11:20:46.351 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[bob]}, now={1646,392846,345292}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ26B681' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.357 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[bob]}, now={1646,392846,345330}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ28CR81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.357 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[bob]}, now={1646,392846,345280}</body>
</message>



*** User 2022-03-04 11:20:46.357 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[bob]}, now={1646,392846,345300}</body>
</message>



*** User 2022-03-04 11:20:46.357 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='09472d7335b334d19992c3c58f91f195'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.362 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='09472d7335b334d19992c3c58f91f195' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.362 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[kate]}, now={1646,392846,362284}</body>
</message>



*** User 2022-03-04 11:20:46.362 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[kate]}, now={1646,392846,362298}</body>
</message>



*** User 2022-03-04 11:20:46.362 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[kate]}, now={1646,392846,362303}</body>
</message>



*** User 2022-03-04 11:20:46.362 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[kate]}, now={1646,392846,362307}</body>
</message>



*** User 2022-03-04 11:20:46.375 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[kate]}, now={1646,392846,362298}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ2AFVO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.378 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[kate]}, now={1646,392846,362307}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ2D6G01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.378 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[kate]}, now={1646,392846,362303}</body>
</message>



*** User 2022-03-04 11:20:46.378 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[kate]}, now={1646,392846,362284}</body>
	<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ2C6MO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.378 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='70d7e80f66eb8479d6d48e90e68333ef'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.385 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='70d7e80f66eb8479d6d48e90e68333ef' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-03-04 11:20:46.385 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[bob,kate]}, now={1646,392846,385112}</body>
</message>



*** User 2022-03-04 11:20:46.385 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[bob,kate]}, now={1646,392846,385128}</body>
</message>



*** User 2022-03-04 11:20:46.385 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[bob,kate]}, now={1646,392846,385137}</body>
</message>



*** User 2022-03-04 11:20:46.385 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[bob,kate]}, now={1646,392846,385144}</body>
</message>



*** User 2022-03-04 11:20:46.442 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[bob,kate]}, now={1646,392846,385128}</body>
	<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ2G2V01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.451 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[bob,kate]}, now={1646,392846,385144}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' id='BMB2MJ2U04O1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-03-04 11:20:46.451 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[bob,kate]}, now={1646,392846,385137}</body>
</message>


Could not find element wait_for_parallel_writer in Config.

Could not find element archive_wait in Config.


*** User 2022-03-04 11:20:46.451 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[bob,kate]}, now={1646,392846,385112}</body>
</message>



*** User 2022-03-04 11:20:46.451 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='5158c1f95dc17ae09281b621bc093d49'>
	<query xmlns='urn:xmpp:mam:1' queryid='page_rsm'>
		<x xmlns='jabber:x:data'/>
		<set>
			<max>50</max>
			<after/>
		</set>
	</query>
</iq>



*** User 2022-03-04 11:20:46.454 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='3a2998fe-12c2-4e17-aec5-f0dc523a9442'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ0N0O01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[],[]}, now={1646,392846,147216}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.454 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='44c50932-e577-43d4-97c0-c3285bbb6288'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ0N1181'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[],[]}, now={1646,392846,147200}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.455 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='0523f369-158f-4457-828a-aba44f8b910a'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ0VVFG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[bob],[]}, now={1646,392846,188235}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.455 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='789f3502-5eb8-4957-81aa-3a1b38c74b6e'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ10F2O1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[bob],[]}, now={1646,392846,188224}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.455 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='09b3c495-503c-487e-9d3a-815f4004a015'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ1FCKO1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[kate],[]}, now={1646,392846,249578}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.455 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='95ae2c84-ebf6-4e69-b01c-644c98bfa2ec'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ1FCL01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[kate],[]}, now={1646,392846,249567}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.455 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='af3a876b-a892-4a7c-b89a-309f1fcc33e5'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ1FCL81'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=3, prefs={roster,[kate],[]}, now={1646,392846,249583}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.456 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='aadd28dd-8938-4bf6-aa27-66b6b53797d5'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ1HBSG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=4, prefs={roster,[kate],[]}, now={1646,392846,249587}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.456 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='381899e6-752e-4bd2-8f1c-28327fcb1b39'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ1L6S01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[kate,bob],[]}, now={1646,392846,275208}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.456 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='6ba8c709-3fbe-49e7-9b4f-9c0de6799e93'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ1L78G1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[kate,bob],[]}, now={1646,392846,275196}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.456 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='9159511f-2f6e-4667-a968-365e8f5d7029'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ1L78O1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=3, prefs={roster,[kate,bob],[]}, now={1646,392846,275213}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.456 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='a0dd2753-c803-45d7-9002-1b90d7c9a5a1'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ1N9EO1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=4, prefs={roster,[kate,bob],[]}, now={1646,392846,275218}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.456 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='dc7d6f9d-1df2-4284-8580-1b05cb5d9362'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ2AFVG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[],[kate]}, now={1646,392846,362298}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.456 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='02906623-d1b5-48a7-b85d-2c1fb9f78580'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BMB2MJ2C6MO1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:20:46Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[],[kate]}, now={1646,392846,362284}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-03-04 11:20:46.456 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='5158c1f95dc17ae09281b621bc093d49' type='result'>
	<fin xmlns='urn:xmpp:mam:1' complete='true'>
		<set xmlns='http://jabber.org/protocol/rsm'>
			<first index='0'>BMB2MJ0N0O01</first>
			<last>BMB2MJ2C6MO1</last>
			<count>14</count>
		</set>
	</fin>
</iq>



*** User 2022-03-04 11:20:46.456 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
<iq type='set' id='c69ebbbb8948fed4394f01d1eafa2a8b'>
	<query xmlns='urn:xmpp:mam:1' queryid='page_rsm'>
		<x xmlns='jabber:x:data'/>
		<set>
			<max>50</max>
			<after>BMB2MJ2C6MO1</after>
		</set>
	</query>
</iq>



*** User 2022-03-04 11:20:46.459 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1' id='c69ebbbb8948fed4394f01d1eafa2a8b' 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-03-04 11:20:46.459 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
</stream:stream>

*** User 2022-03-04 11:20:46.459 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
</stream:stream>

*** User 2022-03-04 11:20:46.459 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
</stream:stream>

*** User 2022-03-04 11:20:46.460 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
</stream:stream>

*** User 2022-03-04 11:20:46.460 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 out
</stream:stream>

*** User 2022-03-04 11:20:46.460 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1031@domain.example.com/res1 in
</stream:stream>
*** CT 2022-03-04 11:20:46.463 *** View log from node ejabberd2@localhost when finished ejabberd2@localhost_529.html
*** CT 2022-03-04 11:20:46.464 *** View log from node mongooseim@localhost when finished mongooseim@localhost_993.html



=== Ended at 2022-03-04 11:20:46
=== successfully completed test case
=== === Returned value: ok