=== 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_async_cache},
     {wait_for_parallel_writer,[pm]},
     {mam_meta_opts,#{archive_chat_markers => false,
                      async_writer =>
                          #{batch_size => 30,enabled => true,
                            flush_interval => 1,pool_size => 16},
                      backend => rdbms,
                      cache =>
                          #{module => internal,number_of_segments => 3,
                            strategy => fifo,time_to_live => 480},
                      cache_users => true,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.10823.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.95874.html"},
     {tc_group_properties,[{name,rdbms_async_cache_prefs_cases},parallel]},
     {tc_group_path,[]},
     {data_dir,"/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/mam_SUITE_data/"},
     {priv_dir,"/home/circleci/project/big_tests/ct_report/ct_run.test@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:09:12


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


*** User 2022-05-25 09:09:12.883 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.884 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='7a4d8b7957d89761' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:09:12.884 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.884 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX21lc3NhZ2VzX2ZpbHRlcmVkX3doZW5fcHJlZnNfZGVmYXVsdF9wb2xpY3lfaXNfcm9zdGVyXzE1NTYAbWF0eWdyeXNh</auth>



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



*** User 2022-05-25 09:09:12.885 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.885 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='efe2a52ff570474c' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:09:12.885 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.885 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='c7bc3d147ca8c70eac59cdab0ffaf369'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-05-25 09:09:12.886 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq id='c7bc3d147ca8c70eac59cdab0ffaf369' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1</jid>
	</bind>
</iq>



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



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



*** User 2022-05-25 09:09:12.887 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<presence/>



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



*** User 2022-05-25 09:09:12.892 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.893 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d54b370e4eabc917' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:09:12.893 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.893 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9tZXNzYWdlc19maWx0ZXJlZF93aGVuX3ByZWZzX2RlZmF1bHRfcG9saWN5X2lzX3Jvc3Rlcl8xNTU2AG1ha3JvbGlrYQ==</auth>



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



*** User 2022-05-25 09:09:12.894 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.895 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='4aaeae5c5d58c286' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:09:12.895 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.895 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='aa66ab3fdbb9e10d41f008d473d076a8'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2022-05-25 09:09:12.895 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq id='aa66ab3fdbb9e10d41f008d473d076a8' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1</jid>
	</bind>
</iq>



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



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



*** User 2022-05-25 09:09:12.895 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<presence/>



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



*** User 2022-05-25 09:09:12.898 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.899 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='cba077773569d0eb' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:09:12.899 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.899 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGthdGVfbWVzc2FnZXNfZmlsdGVyZWRfd2hlbl9wcmVmc19kZWZhdWx0X3BvbGljeV9pc19yb3N0ZXJfMTU1NgBtYWtyb3dlO3A=</auth>



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



*** User 2022-05-25 09:09:12.900 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.900 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='f6d76e94df1ef47c' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2022-05-25 09:09:12.900 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@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:09:12.900 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='e4fae856ab5b3b096cee4e2ee9b513b1'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



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



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



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



*** User 2022-05-25 09:09:12.901 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<presence/>



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



*** User 2022-05-25 09:09:12.904 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<presence type='subscribe' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com'/>



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



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



*** User 2022-05-25 09:09:12.909 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<presence type='subscribed' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com'/>



*** User 2022-05-25 09:09:12.964 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='push7badcb2434f32135' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com'/>
	</query>
</iq>



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



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



*** User 2022-05-25 09:09:12.964 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='pushb59fb13ba1ab3730' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-25 09:09:12.964 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<presence type='subscribe' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com'/>



*** User 2022-05-25 09:09:12.970 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='pusha0a47654c2705a0b' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com'/>
	</query>
</iq>



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



*** User 2022-05-25 09:09:12.970 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='pushdf74d2e1347adb93' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item ask='subscribe' subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-25 09:09:12.970 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<presence type='subscribed' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com'/>



*** User 2022-05-25 09:09:12.976 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='push62f7ab771d97f0c4' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='both' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com'/>
	</query>
</iq>



*** User 2022-05-25 09:09:12.976 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='pushae8325138fc7ab58' type='set'>
	<query xmlns='jabber:iq:roster'>
		<item subscription='both' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com'/>
	</query>
</iq>



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



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



*** User 2022-05-25 09:09:12.976 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='22ce8e4971d93cbbd1e6f89081fbeef3'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never/>
	</prefs>
</iq>



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



*** User 2022-05-25 09:09:12.987 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[]}, now={1653,469752,987807}</body>
</message>



*** User 2022-05-25 09:09:12.987 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[]}, now={1653,469752,987816}</body>
</message>



*** User 2022-05-25 09:09:12.988 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[]}, now={1653,469752,987838}</body>
</message>



*** User 2022-05-25 09:09:12.988 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[]}, now={1653,469752,987843}</body>
</message>



*** User 2022-05-25 09:09:12.997 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[]}, now={1653,469752,987816}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL329H01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.000 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[]}, now={1653,469752,987843}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL33IBO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.000 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[]}, now={1653,469752,987807}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL329H81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.000 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[]}, now={1653,469752,987838}</body>
</message>



*** User 2022-05-25 09:09:13.001 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='3e3403f86dd63577e2b843bdfddd37bf'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:09:13.003 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='3e3403f86dd63577e2b843bdfddd37bf' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:09:13.003 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[bob],[]}, now={1653,469753,3689}</body>
</message>



*** User 2022-05-25 09:09:13.003 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[bob],[]}, now={1653,469753,3699}</body>
</message>



*** User 2022-05-25 09:09:13.003 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[bob],[]}, now={1653,469753,3704}</body>
</message>



*** User 2022-05-25 09:09:13.003 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[bob],[]}, now={1653,469753,3712}</body>
</message>



*** User 2022-05-25 09:09:13.065 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[bob],[]}, now={1653,469753,3699}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL350G81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.066 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[bob],[]}, now={1653,469753,3712}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3JP901' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.066 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[bob],[]}, now={1653,469753,3689}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL350GO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.066 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[bob],[]}, now={1653,469753,3704}</body>
</message>



*** User 2022-05-25 09:09:13.066 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='71fb22a41d5eb9bface4f856cb0037f0'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:09:13.069 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='71fb22a41d5eb9bface4f856cb0037f0' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:09:13.069 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[kate],[]}, now={1653,469753,69861}</body>
</message>



*** User 2022-05-25 09:09:13.069 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[kate],[]}, now={1653,469753,69872}</body>
</message>



*** User 2022-05-25 09:09:13.070 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[kate],[]}, now={1653,469753,69877}</body>
</message>



*** User 2022-05-25 09:09:13.070 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[kate],[]}, now={1653,469753,69881}</body>
</message>



*** User 2022-05-25 09:09:13.074 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[kate],[]}, now={1653,469753,69872}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3LELG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.077 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[kate],[]}, now={1653,469753,69881}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3M7981' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.077 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[kate],[]}, now={1653,469753,69877}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3L4KO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.077 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[kate],[]}, now={1653,469753,69861}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3LEL81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.077 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='25114a169f50fb3e0e1a50ee731f52e0'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:09:13.080 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='25114a169f50fb3e0e1a50ee731f52e0' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</always>
		<never/>
	</prefs>
</iq>



*** User 2022-05-25 09:09:13.080 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[kate,bob],[]}, now={1653,469753,80761}</body>
</message>



*** User 2022-05-25 09:09:13.080 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[kate,bob],[]}, now={1653,469753,80776}</body>
</message>



*** User 2022-05-25 09:09:13.080 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[kate,bob],[]}, now={1653,469753,80784}</body>
</message>



*** User 2022-05-25 09:09:13.081 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[kate,bob],[]}, now={1653,469753,80791}</body>
</message>



*** User 2022-05-25 09:09:13.083 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[kate,bob],[]}, now={1653,469753,80776}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3NQ381' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.085 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[kate,bob],[]}, now={1653,469753,80791}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3O7Q01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.085 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[kate,bob],[]}, now={1653,469753,80761}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3NQ3G1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.085 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[kate,bob],[]}, now={1653,469753,80784}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3O5MG1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.085 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='5e9bb136208258adc3d77a1ac60b988b'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-05-25 09:09:13.087 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='5e9bb136208258adc3d77a1ac60b988b' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-05-25 09:09:13.088 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[bob]}, now={1653,469753,87934}</body>
</message>



*** User 2022-05-25 09:09:13.088 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[bob]}, now={1653,469753,87944}</body>
</message>



*** User 2022-05-25 09:09:13.088 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[bob]}, now={1653,469753,87949}</body>
</message>



*** User 2022-05-25 09:09:13.088 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[bob]}, now={1653,469753,87977}</body>
</message>



*** User 2022-05-25 09:09:13.091 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[bob]}, now={1653,469753,87944}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3PJ401' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.096 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[bob]}, now={1653,469753,87977}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3QVP01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.096 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[bob]}, now={1653,469753,87934}</body>
</message>



*** User 2022-05-25 09:09:13.096 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[bob]}, now={1653,469753,87949}</body>
</message>



*** User 2022-05-25 09:09:13.096 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='b2bd39caca4e7d75daadf874617ceffe'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</never>
	</prefs>
</iq>



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



*** User 2022-05-25 09:09:13.099 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[kate]}, now={1653,469753,99945}</body>
</message>



*** User 2022-05-25 09:09:13.100 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[kate]}, now={1653,469753,99955}</body>
</message>



*** User 2022-05-25 09:09:13.100 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[kate]}, now={1653,469753,99961}</body>
</message>



*** User 2022-05-25 09:09:13.100 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[kate]}, now={1653,469753,99965}</body>
</message>



*** User 2022-05-25 09:09:13.165 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[kate]}, now={1653,469753,99955}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL3SG581' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.165 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[kate]}, now={1653,469753,99965}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL4BQI01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.165 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[kate]}, now={1653,469753,99961}</body>
</message>



*** User 2022-05-25 09:09:13.165 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[kate]}, now={1653,469753,99945}</body>
	<stanza-id by='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL4BQI81' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.165 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='f562ed0ca427bf14304d1aa53619e81c'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-05-25 09:09:13.168 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='f562ed0ca427bf14304d1aa53619e81c' type='result'>
	<prefs xmlns='urn:xmpp:mam:1' default='roster'>
		<always/>
		<never>
			<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
			<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com</jid>
		</never>
	</prefs>
</iq>



*** User 2022-05-25 09:09:13.168 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=1, prefs={roster,[],[bob,kate]}, now={1653,469753,168323}</body>
</message>



*** User 2022-05-25 09:09:13.168 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=2, prefs={roster,[],[bob,kate]}, now={1653,469753,168338}</body>
</message>



*** User 2022-05-25 09:09:13.168 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=3, prefs={roster,[],[bob,kate]}, now={1653,469753,168344}</body>
</message>



*** User 2022-05-25 09:09:13.168 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
	<body>n=4, prefs={roster,[],[bob,kate]}, now={1653,469753,168379}</body>
</message>



*** User 2022-05-25 09:09:13.170 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=2, prefs={roster,[],[bob,kate]}, now={1653,469753,168338}</body>
	<stanza-id by='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL4D7C01' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.172 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=4, prefs={roster,[],[bob,kate]}, now={1653,469753,168379}</body>
	<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' id='BNUIDL4DIKO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2022-05-25 09:09:13.172 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=1, prefs={roster,[],[bob,kate]}, now={1653,469753,168323}</body>
</message>



*** User 2022-05-25 09:09:13.172 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xml:lang='en' type='chat'>
	<body>n=3, prefs={roster,[],[bob,kate]}, now={1653,469753,168344}</body>
</message>


Could not find element archive_wait in Config.


*** User 2022-05-25 09:09:13.174 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
<iq type='set' id='5dc26176807bdf4356809e0f0f4edecf'>
	<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:09:13.177 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='eaa57a66-74fa-4a8a-a130-649f12e53bf0'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL31VJ81'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:12.991693Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[],[]}, now={1653,469752,987816}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.177 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='98822d01-15f6-4db6-8ac9-9c9f32560289'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL329H81'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:12.992965Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[],[]}, now={1653,469752,987807}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.177 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='cd1f0ff6-1071-4c84-8ef3-9e2654581ea6'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL34V2O1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.003915Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[bob],[]}, now={1653,469753,3699}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.177 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='052458e5-f51a-4876-98a7-339b5a70b73d'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL350GO1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.004099Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[bob],[]}, now={1653,469753,3689}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.177 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='daee94ac-f1f5-4289-8451-8d7909eedc9f'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL3L4KO1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.070163Z' from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=3, prefs={roster,[kate],[]}, now={1653,469753,69877}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.178 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='b46e49b1-f6a8-4167-9de5-782a43731daa'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL3LEL01'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.071444Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[kate],[]}, now={1653,469753,69872}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.179 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='22c06509-52e7-4452-b2b8-c8e2c322151c'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL3LEL81'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.071445Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[kate],[]}, now={1653,469753,69861}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.179 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='0fccb0be-bbbe-4b67-bea3-c9e090515ed6'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL3M3QG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.074154Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=4, prefs={roster,[kate],[]}, now={1653,469753,69881}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.179 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='340e5669-c39a-43c6-9cef-8c21a969754d'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL3NPKG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.081042Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[kate,bob],[]}, now={1653,469753,80776}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.179 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='1edf9891-1587-424e-beb6-2d8a78303595'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL3NQ3G1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.081102Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[kate,bob],[]}, now={1653,469753,80761}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.179 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='acda82e8-1469-4e02-9975-19e83345cb65'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL3O5MG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.082586Z' from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=3, prefs={roster,[kate,bob],[]}, now={1653,469753,80784}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.179 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='8124184f-5571-4655-804a-55f4a6e56a1e'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL3O7PG1'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.082854Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=4, prefs={roster,[kate,bob],[]}, now={1653,469753,80791}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.179 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='09945e80-2d11-418d-8c67-fdf09f82394e'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL3SG501'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.100308Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=2, prefs={roster,[],[kate]}, now={1653,469753,99955}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.179 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='0fea768e-2dd4-4829-8b51-4d1cfa23d4ff'>
	<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BNUIDL4BQI81'>
		<forwarded xmlns='urn:xmpp:forward:0'>
			<delay xmlns='urn:xmpp:delay' stamp='2022-05-25T09:09:13.163081Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1'/>
			<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' type='chat'>
				<body>n=1, prefs={roster,[],[kate]}, now={1653,469753,99945}</body>
			</message>
		</forwarded>
	</result>
</message>



*** User 2022-05-25 09:09:13.179 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='5dc26176807bdf4356809e0f0f4edecf' type='result'>
	<fin xmlns='urn:xmpp:mam:1' complete='true'>
		<set xmlns='http://jabber.org/protocol/rsm'>
			<first index='0'>BNUIDL31VJ81</first>
			<last>BNUIDL4BQI81</last>
			<count>14</count>
		</set>
	</fin>
</iq>



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



*** User 2022-05-25 09:09:13.181 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
<iq from='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1' id='01ad7fc77852c3402afa2461212e2f0b' 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:09:13.181 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
</stream:stream>

*** User 2022-05-25 09:09:13.181 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
</stream:stream>

*** User 2022-05-25 09:09:13.182 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
</stream:stream>

*** User 2022-05-25 09:09:13.182 ***
bob_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
</stream:stream>

*** User 2022-05-25 09:09:13.183 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 out
</stream:stream>

*** User 2022-05-25 09:09:13.183 ***
alice_messages_filtered_when_prefs_default_policy_is_roster_1556@domain.example.com/res1 in
</stream:stream>
*** CT 2022-05-25 09:09:13.194 *** View log from node ejabberd2@localhost when finished ejabberd2@localhost_424.html
*** CT 2022-05-25 09:09:13.195 *** View log from node mongooseim@localhost when finished mongooseim@localhost_1795.html



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