=== 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},
     {mam_meta_opts,#{archive_chat_markers => false,
                      async_writer =>
                          #{batch_size => 30,enabled => false,
                            flush_interval => 2000,pool_size => 16},
                      backend => rdbms,
                      cache =>
                          #{module => internal,number_of_segments => 3,
                            strategy => fifo,time_to_live => 480},
                      cache_users => false,db_jid_format => mam_jid_rfc,
                      db_message_format => mam_message_xml,
                      default_result_limit => 50,full_text_search => true,
                      is_archivable_message => mod_mam_utils,
                      max_result_limit => 50,message_retraction => true,
                      no_stanzaid_element => false,
                      pm =>
                          #{archive_groupchats => false,
                            same_mam_id_for_peers => false},
                      send_message => mod_mam_utils,
                      user_prefs_store => rdbms}},
     {watchdog,<0.1647.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@f0b09cc3aef4.2022-05-25_09.03.38/big_tests.tests.mam_SUITE.logs/run.2022-05-25_09.08.32/mam_suite.messages_filtered_when_prefs_default_policy_is_roster.66946.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@f0b09cc3aef4.2022-05-25_09.03.38/big_tests.tests.mam_SUITE.logs/run.2022-05-25_09.08.32/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 => #{iqdisc => one_queue,report_commands_node => false},
        mod_amp => #{},
        mod_bosh =>
            #{backend => mnesia,inactivity => 30,max_pause => 120,
              max_wait => infinity,server_acks => false},
        mod_cache_users =>
            #{number_of_segments => 5,strategy => fifo,time_to_live => 2},
        mod_carboncopy => #{iqdisc => no_queue},
        mod_commands => #{},
        mod_disco =>
            #{extra_domains => [],iqdisc => one_queue,server_info => [],
              users_can_see_hidden_services => false},
        mod_muc =>
            #{access => muc,access_admin => none,access_create => muc_create,
              access_persistent => all,backend => rdbms,
              default_room =>
                  #{affiliations => [],allow_change_subj => true,
                    allow_multiple_sessions => false,
                    allow_private_messages => true,allow_query_users => true,
                    allow_user_invites => false,
                    allow_visitor_nickchange => true,
                    allow_visitor_status => true,anonymous => true,
                    description => <<>>,logging => false,max_users => 200,
                    maygetmemberlist => [],members_by_default => true,
                    members_only => false,moderated => true,password => <<>>,
                    password_protected => false,persistent => false,
                    public => true,public_list => true,subject => <<>>,
                    subject_author => <<>>,title => <<>>},
              hibernate_timeout => 2000,
              hibernated_room_check_interval => 1000,
              hibernated_room_timeout => 2000,history_size => 20,
              host => {prefix,<<"groupchats.">>},
              http_auth_pool => none,load_permanent_rooms_at_startup => false,
              max_room_desc => infinity,max_room_id => infinity,
              max_room_name => infinity,max_user_conferences => 10,
              max_users => 200,max_users_admin_threshold => 5,
              min_message_interval => 0,min_presence_interval => 0,
              room_shaper => none,user_message_shaper => none,
              user_presence_shaper => none},
        mod_muc_commands => #{},mod_muc_light_commands => #{},
        mod_muc_log =>
            #{access_log => muc,css_file => false,dirname => room_jid,
              dirtype => subdirs,file_format => html,outdir => "/tmp/muclogs",
              spam_prevention => true,timezone => local,
              top_link => {"/","Home"}},
        mod_register =>
            #{access => register,
              ip_access => [{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}],
              iqdisc => one_queue,password_strength => 0,
              registration_watchers => []},
        mod_roster =>
            #{backend => rdbms,iqdisc => one_queue,store_current_id => false,
              versioning => false},
        mod_sic => #{iqdisc => one_queue},
        mod_stream_management =>
            #{ack => true,ack_freq => 1,backend => mnesia,buffer => true,
              buffer_max => 100,resume_timeout => 600,
              stale_h =>
                  #{enabled => false,geriatric => 3600,repeat_after => 1800}},
        mod_vcard =>
            #{backend => rdbms,
              host => {prefix,<<"vjud.">>},
              iqdisc => parallel,matches => 30,search => true}}},
     {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@f0b09cc3aef4.2022-05-25_09.03.38"

=== Started at 2022-05-25 09:08:47


*** CT 2022-05-25 09:08:47.052 *** View log from node mongooseim@localhost when started mongooseim@localhost_1734.html
*** CT 2022-05-25 09:08:47.052 *** View log from node ejabberd2@localhost when started ejabberd2@localhost_424.html
Could not find element props in Config.


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

*** User 2022-05-25 09:08:47.078 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='98eb995ae7fa485a' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:08:47.078 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:features>
	<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
	<compression xmlns='http://jabber.org/features/compress'>
		<method>zlib</method>
	</compression>
	<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
		<mechanism>SCRAM-SHA-256</mechanism>
		<mechanism>PLAIN</mechanism>
	</mechanisms>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2022-05-25 09:08:47.078 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX21lc3NhZ2VzX2ZpbHRlcmVkX3doZW5fcHJlZnNfZGVmYXVsdF9wb2xpY3lfaXNfcm9zdGVyXzEyODYAbWF0eWdyeXNh</auth>



*** User 2022-05-25 09:08:47.079 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



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

*** User 2022-05-25 09:08:47.080 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='7b0e86a191d27a4d' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:08:47.080 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:features>
	<compression xmlns='http://jabber.org/features/compress'>
		<method>zlib</method>
	</compression>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2022-05-25 09:08:47.080 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='af6139444cadf6150486eabd212ef7da'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-05-25 09:08:47.080 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq id='af6139444cadf6150486eabd212ef7da' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-05-25 09:08:47.080 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='d1f3aeb80757e1a4b881863fddb83331'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-25 09:08:47.080 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq type='result' id='d1f3aeb80757e1a4b881863fddb83331'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-25 09:08:47.081 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<presence/>



*** User 2022-05-25 09:08:47.093 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<presence from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en'/>



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

*** User 2022-05-25 09:08:47.094 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='e347eb1af69b0edd' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:08:47.094 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:features>
	<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
	<compression xmlns='http://jabber.org/features/compress'>
		<method>zlib</method>
	</compression>
	<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
		<mechanism>SCRAM-SHA-256</mechanism>
		<mechanism>PLAIN</mechanism>
	</mechanisms>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2022-05-25 09:08:47.094 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9tZXNzYWdlc19maWx0ZXJlZF93aGVuX3ByZWZzX2RlZmF1bHRfcG9saWN5X2lzX3Jvc3Rlcl8xMjg2AG1ha3JvbGlrYQ==</auth>



*** User 2022-05-25 09:08:47.095 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



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

*** User 2022-05-25 09:08:47.095 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='4a7c7609f44c1b5c' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:08:47.095 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:features>
	<compression xmlns='http://jabber.org/features/compress'>
		<method>zlib</method>
	</compression>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2022-05-25 09:08:47.095 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='ba7e58321b33ca728b415310b3834862'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-05-25 09:08:47.096 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq id='ba7e58321b33ca728b415310b3834862' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-05-25 09:08:47.096 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='0a9c0b1b657d04709e3dface92768184'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-25 09:08:47.096 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq type='result' id='0a9c0b1b657d04709e3dface92768184'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-25 09:08:47.096 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<presence/>



*** User 2022-05-25 09:08:47.098 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<presence from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en'/>



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

*** User 2022-05-25 09:08:47.099 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='de0283ca5abe1de4' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:08:47.099 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:features>
	<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
	<compression xmlns='http://jabber.org/features/compress'>
		<method>zlib</method>
	</compression>
	<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
		<mechanism>SCRAM-SHA-256</mechanism>
		<mechanism>PLAIN</mechanism>
	</mechanisms>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2022-05-25 09:08:47.099 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGthdGVfbWVzc2FnZXNfZmlsdGVyZWRfd2hlbl9wcmVmc19kZWZhdWx0X3BvbGljeV9pc19yb3N0ZXJfMTI4NgBtYWtyb3dlO3A=</auth>



*** User 2022-05-25 09:08:47.102 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



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

*** User 2022-05-25 09:08:47.102 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='29d40202fcca3002' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:08:47.102 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<stream:features>
	<compression xmlns='http://jabber.org/features/compress'>
		<method>zlib</method>
	</compression>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2022-05-25 09:08:47.102 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='18ee3f996952393655c7e111d6978954'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-05-25 09:08:47.102 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq id='18ee3f996952393655c7e111d6978954' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2022-05-25 09:08:47.102 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='ab949f10530fd7e091c86815703f0aa6'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-25 09:08:47.102 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq type='result' id='ab949f10530fd7e091c86815703f0aa6'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-05-25 09:08:47.102 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<presence/>



*** User 2022-05-25 09:08:47.106 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<presence from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en'/>



*** User 2022-05-25 09:08:47.106 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<presence type='subscribe' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>



*** User 2022-05-25 09:08:47.165 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='pushbe6f29f16cd1b2ff' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item ask='subscribe' subscription='none' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-25 09:08:47.165 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<presence from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='subscribe'/>



*** User 2022-05-25 09:08:47.165 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<presence type='subscribed' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>



*** User 2022-05-25 09:08:47.182 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='push1ceba4024d0e76bb' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-25 09:08:47.182 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<presence from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='subscribed'/>



*** User 2022-05-25 09:08:47.182 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<presence from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en'/>



*** User 2022-05-25 09:08:47.182 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='pushdcad2c6fe6ae5470' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-25 09:08:47.183 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<presence type='subscribe' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>



*** User 2022-05-25 09:08:47.198 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='push9809fbc3292f881b' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-25 09:08:47.198 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<presence from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='subscribe'/>



*** User 2022-05-25 09:08:47.199 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='pushc46ae2f26bf9bdc2' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item ask='subscribe' subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-25 09:08:47.199 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<presence type='subscribed' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>



*** User 2022-05-25 09:08:47.207 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='pushb5fde4694f041752' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='both' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-25 09:08:47.207 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='push1093160f3a7fa98c' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='both' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-25 09:08:47.207 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<presence from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='subscribed'/>



*** User 2022-05-25 09:08:47.208 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<presence from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en'/>



*** User 2022-05-25 09:08:47.208 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='609c1bf254597b8ba0adba0f275883c7'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.226 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='609c1bf254597b8ba0adba0f275883c7' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.226 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[]}, now={1653,469727,226721}</body>
</message>



*** User 2022-05-25 09:08:47.226 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[]}, now={1653,469727,226735}</body>
</message>



*** User 2022-05-25 09:08:47.226 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[]}, now={1653,469727,226742}</body>
</message>



*** User 2022-05-25 09:08:47.227 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[]}, now={1653,469727,226749}</body>
</message>



*** User 2022-05-25 09:08:47.239 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[]}, now={1653,469727,226735}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEUH2KO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.268 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[]}, now={1653,469727,226749}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEUJM881' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.268 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[]}, now={1653,469727,226742}</body>
</message>



*** User 2022-05-25 09:08:47.268 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[]}, now={1653,469727,226721}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEUH2L01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.268 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='39fe7368edacd0812da32ce1847d9951'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.272 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='39fe7368edacd0812da32ce1847d9951' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.272 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[bob],[]}, now={1653,469727,272375}</body>
</message>



*** User 2022-05-25 09:08:47.272 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[bob],[]}, now={1653,469727,272386}</body>
</message>



*** User 2022-05-25 09:08:47.272 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[bob],[]}, now={1653,469727,272391}</body>
</message>



*** User 2022-05-25 09:08:47.272 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[bob],[]}, now={1653,469727,272395}</body>
</message>



*** User 2022-05-25 09:08:47.285 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[bob],[]}, now={1653,469727,272386}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEUSLN01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.305 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[bob],[]}, now={1653,469727,272395}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEUV51O1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.306 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[bob],[]}, now={1653,469727,272391}</body>
</message>



*** User 2022-05-25 09:08:47.306 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[bob],[]}, now={1653,469727,272375}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEUQTS01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.306 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='2a79c80407e600d4ce7bb116fcb08303'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.310 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='2a79c80407e600d4ce7bb116fcb08303' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.310 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[kate],[]}, now={1653,469727,310082}</body>
</message>



*** User 2022-05-25 09:08:47.310 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[kate],[]}, now={1653,469727,310100}</body>
</message>



*** User 2022-05-25 09:08:47.310 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[kate],[]}, now={1653,469727,310110}</body>
</message>



*** User 2022-05-25 09:08:47.310 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[kate],[]}, now={1653,469727,310118}</body>
</message>



*** User 2022-05-25 09:08:47.317 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[kate],[]}, now={1653,469727,310100}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEV4G281' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.324 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[kate],[]}, now={1653,469727,310118}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEV6DK01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.324 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[kate],[]}, now={1653,469727,310082}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEV4G2G1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.324 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[kate],[]}, now={1653,469727,310110}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEV4G2O1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.325 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='8b17a36a453cfb93b9224159c079203c'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.366 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='8b17a36a453cfb93b9224159c079203c' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.366 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[kate,bob],[]}, now={1653,469727,366718}</body>
</message>



*** User 2022-05-25 09:08:47.366 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[kate,bob],[]}, now={1653,469727,366731}</body>
</message>



*** User 2022-05-25 09:08:47.366 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[kate,bob],[]}, now={1653,469727,366736}</body>
</message>



*** User 2022-05-25 09:08:47.366 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[kate,bob],[]}, now={1653,469727,366741}</body>
</message>



*** User 2022-05-25 09:08:47.375 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[kate,bob],[]}, now={1653,469727,366731}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEVIGTO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.384 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[kate,bob],[]}, now={1653,469727,366741}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEVLAB01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.384 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[kate,bob],[]}, now={1653,469727,366718}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEVIGT81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.384 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[kate,bob],[]}, now={1653,469727,366736}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEVIGTG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.384 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='3464c787cb0bf08d28fb65eee9d4e057'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.388 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='3464c787cb0bf08d28fb65eee9d4e057' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.388 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[bob]}, now={1653,469727,388420}</body>
</message>



*** User 2022-05-25 09:08:47.388 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[bob]}, now={1653,469727,388431}</body>
</message>



*** User 2022-05-25 09:08:47.388 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[bob]}, now={1653,469727,388436}</body>
</message>



*** User 2022-05-25 09:08:47.388 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[bob]}, now={1653,469727,388440}</body>
</message>



*** User 2022-05-25 09:08:47.395 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[bob]}, now={1653,469727,388431}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEVN9KO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.403 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[bob]}, now={1653,469727,388440}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEVOMDG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.403 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[bob]}, now={1653,469727,388420}</body>
</message>



*** User 2022-05-25 09:08:47.403 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[bob]}, now={1653,469727,388436}</body>
</message>



*** User 2022-05-25 09:08:47.403 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='cda6a17ac9c874d2faa574954008aa6b'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.408 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='cda6a17ac9c874d2faa574954008aa6b' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.409 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[kate]}, now={1653,469727,408778}</body>
</message>



*** User 2022-05-25 09:08:47.409 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[kate]}, now={1653,469727,408794}</body>
</message>



*** User 2022-05-25 09:08:47.409 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[kate]}, now={1653,469727,408803}</body>
</message>



*** User 2022-05-25 09:08:47.409 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[kate]}, now={1653,469727,408810}</body>
</message>



*** User 2022-05-25 09:08:47.469 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[kate]}, now={1653,469727,408794}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEVSC9O1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.474 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[kate]}, now={1653,469727,408810}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDF0AU801' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.474 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[kate]}, now={1653,469727,408803}</body>
</message>



*** User 2022-05-25 09:08:47.474 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[kate]}, now={1653,469727,408778}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDEVSC9G1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.474 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='94984ae66c9066c7870463628d541368'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.479 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='94984ae66c9066c7870463628d541368' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-05-25 09:08:47.479 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[bob,kate]}, now={1653,469727,479260}</body>
</message>



*** User 2022-05-25 09:08:47.479 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[bob,kate]}, now={1653,469727,479271}</body>
</message>



*** User 2022-05-25 09:08:47.479 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[bob,kate]}, now={1653,469727,479277}</body>
</message>



*** User 2022-05-25 09:08:47.479 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[bob,kate]}, now={1653,469727,479281}</body>
</message>



*** User 2022-05-25 09:08:47.485 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[bob,kate]}, now={1653,469727,479271}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDF0DDS81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.489 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[bob,kate]}, now={1653,469727,479281}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' id='BNUIDF0ENPO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:08:47.489 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[bob,kate]}, now={1653,469727,479260}</body>
</message>


Could not find element wait_for_parallel_writer in Config.

Could not find element archive_wait in Config.


*** User 2022-05-25 09:08:47.489 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[bob,kate]}, now={1653,469727,479277}</body>
</message>



*** User 2022-05-25 09:08:47.489 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='a6da46b30968bfc79f750b72e1523494'>
	<query xmlns='urn:xmpp:mam:1' queryid='page_rsm'>
		<x xmlns='jabber:x:data'/>
		<set>
			<max>50</max>
			<after/>
		</set>
	</query>
</iq>



*** User 2022-05-25 09:08:47.492 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='9dc21a73-f5bc-42ba-97e8-e21528840e51'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEUFPOG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.227106Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[],[]}, now={1653,469727,226735}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.492 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='253bd330-e692-4ff7-9eed-1898e35fd198'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEUH2L01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.232340Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[],[]}, now={1653,469727,226721}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.492 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='7a03303a-7573-4876-9b45-d2b62d66c563'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEUQTRG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.272686Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[bob],[]}, now={1653,469727,272386}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.492 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='b2a08d9b-cee9-43d3-a949-fa7a01d5cd3c'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEUQTS01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.272688Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[bob],[]}, now={1653,469727,272375}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.492 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='10f4a6f4-ce9b-4405-a0da-4ac414756ad9'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEV4G201'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.311880Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[kate],[]}, now={1653,469727,310100}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.492 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='bd6bf89d-2251-4066-ad22-98873b4f0b52'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEV4G2G1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.311882Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[kate],[]}, now={1653,469727,310082}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.493 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='e6325ca4-c2c5-43da-9274-25d2de377ee6'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEV4G2O1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.311883Z' from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=3, prefs={roster,[kate],[]}, now={1653,469727,310110}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.493 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='af5f0f0d-c660-41e1-8bc5-6eb3c4b5fb5f'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEV5QC01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.317296Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=4, prefs={roster,[kate],[]}, now={1653,469727,310118}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.493 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='3e99595e-0eb5-4fe5-90b2-8abdec106354'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEVHVE01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.367096Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[kate,bob],[]}, now={1653,469727,366731}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.493 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='c0361cae-e865-45e8-98c6-59e1ffcda3e4'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEVIGT81'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.369333Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[kate,bob],[]}, now={1653,469727,366718}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.493 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='36dad197-53e2-4a31-8a30-8a3efd23792b'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEVIGTG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.369334Z' from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=3, prefs={roster,[kate,bob],[]}, now={1653,469727,366736}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.493 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='6ff517e8-d803-4377-8e49-db82c893403a'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEVJT981'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.375013Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=4, prefs={roster,[kate,bob],[]}, now={1653,469727,366741}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.493 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='067fb955-8031-436c-9d8e-e5f114e2830c'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEVSC981'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.409701Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[],[kate]}, now={1653,469727,408794}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.493 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='47727e55-0256-49b1-8c1a-e295ee2e7235'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDEVSC9G1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:08:47.409702Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[],[kate]}, now={1653,469727,408778}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:08:47.493 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='a6da46b30968bfc79f750b72e1523494' type='result'>
	<fin xmlns='urn:xmpp:mam:1' complete='true'>
		<set xmlns='http://jabber.org/protocol/rsm'>
			<first index='0'>BNUIDEUFPOG1</first>
			<last>BNUIDEVSC9G1</last>
			<count>14</count>
		</set>
	</fin>
</iq>



*** User 2022-05-25 09:08:47.493 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
<iq type='set' id='77fa92567b5d0a0a21dfa7c88697e299'>
	<query xmlns='urn:xmpp:mam:1' queryid='page_rsm'>
		<x xmlns='jabber:x:data'/>
		<set>
			<max>50</max>
			<after>BNUIDEVSC9G1</after>
		</set>
	</query>
</iq>



*** User 2022-05-25 09:08:47.496 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1' id='77fa92567b5d0a0a21dfa7c88697e299' 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-05-25 09:08:47.496 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
</stream:stream>

*** User 2022-05-25 09:08:47.496 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
</stream:stream>

*** User 2022-05-25 09:08:47.496 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
</stream:stream>

*** User 2022-05-25 09:08:47.497 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
</stream:stream>

*** User 2022-05-25 09:08:47.497 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 out
</stream:stream>

*** User 2022-05-25 09:08:47.497 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1286@domain.example.com/res1 in
</stream:stream>
*** CT 2022-05-25 09:08:47.499 *** View log from node ejabberd2@localhost when finished ejabberd2@localhost_424.html
*** CT 2022-05-25 09:08:47.500 *** View log from node mongooseim@localhost when finished mongooseim@localhost_1736.html



=== Ended at 2022-05-25 09:08:47
=== successfully completed test case
=== === Returned value: ok