=== Test case: mam_SUITE:messages_filtered_when_prefs_default_policy_is_roster/1 (click for source code)
=== Config value:
[{basic_group,prefs_cases},
{configuration,rdbms_mnesia},
{watchdog,<0.31874.0>},
{mod_offline_loaded,false},
{escalus_user_db,{module,escalus_ejabberd}},
{mim_data_dir,"/home/circleci/project/big_tests/tests/mam_SUITE_data"},
{preset,"odbc_mssql_mnesia"},
{tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@998557c7e1d1.2022-01-27_12.27.57/big_tests.tests.mam_SUITE.logs/run.2022-01-27_12.31.28/mam_suite.messages_filtered_when_prefs_default_policy_is_roster.36228.html"},
{tc_group_properties,[{name,rdbms_mnesia_prefs_cases},parallel]},
{tc_group_path,[]},
{data_dir,"/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/mam_SUITE_data/"},
{priv_dir,"/home/circleci/project/big_tests/ct_report/ct_run.test@998557c7e1d1.2022-01-27_12.27.57/big_tests.tests.mam_SUITE.logs/run.2022-01-27_12.31.28/log_private/"},
{config_backup,#{[shaper,fast] => {ok,#{max_rate => 50000}},
[shaper,mam_shaper] => {ok,#{max_rate => 1}},
[shaper,normal] => {ok,#{max_rate => 1000}},
[{access,<<"test type">>},max_user_sessions] =>
{ok,[#{acl => all,value => 10}]}}},
{{saved_modules,mongooseim@localhost,<<"test type">>},
#{mod_adhoc => [],mod_amp => [],mod_bosh => [],
mod_cache_users => [{number_of_segments,5},{time_to_live,2}],
mod_carboncopy => [],mod_commands => [],
mod_disco => [{users_can_see_hidden_services,false}],
mod_mam => [{archive_groupchats,false}],
mod_mam_mnesia_prefs => [{pm,true}],
mod_mam_rdbms_arch => [],
mod_mam_rdbms_user => [{pm,true}],
mod_muc =>
[{host,{prefix,<<"groupchats.">>}},
{backend,rdbms},
{hibernate_timeout,2000},
{hibernated_room_check_interval,1000},
{hibernated_room_timeout,2000},
{access,muc},
{access_create,muc_create}],
mod_muc_commands => [],mod_muc_light_commands => [],
mod_muc_log => [{outdir,"/tmp/muclogs"},{access_log,muc}],
mod_register =>
[{access,register},
{ip_access,[{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]},
{welcome_message,{[],[]}}],
mod_roster => [{backend,rdbms}],
mod_sic => [],mod_stream_management => [],
mod_vcard => [{backend,rdbms},{host,{prefix,<<"vjud.">>}}]}},
{escalus_users,[{alice,[{username,<<"alicE">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"matygrysa">>}]},
{bob,[{username,<<"bOb">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"makrolika">>}]},
{kate,[{username,<<"kate">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"makrowe;p">>}]},
{carol,[{username,<<"carol">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"jinglebells">>},
{transport,escalus_bosh},
{path,<<"/http-bind">>},
{port,5280}]}]}]
=== Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@998557c7e1d1.2022-01-27_12.27.57"
=== Started at 2022-01-27 12:32:11
Could not find element props in Config.
*** User 2022-01-27 12:32:11.859 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 12:32:11.859 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d9e4593d3216b701' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:32:11.859 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:features>
<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
<mechanism>SCRAM-SHA-256</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 12:32:11.859 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX21lc3NhZ2VzX2ZpbHRlcmVkX3doZW5fcHJlZnNfZGVmYXVsdF9wb2xpY3lfaXNfcm9zdGVyXzExNTAAbWF0eWdyeXNh</auth>
*** User 2022-01-27 12:32:11.898 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 12:32:11.898 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 12:32:11.898 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='60a4d6d60a9cd057' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:32:11.898 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:features>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 12:32:11.898 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='be7c09b790165075bf59404ebf2397de'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 12:32:11.899 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq id='be7c09b790165075bf59404ebf2397de' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1</jid>
</bind>
</iq>
*** User 2022-01-27 12:32:11.899 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='6bf8b1fd3bd265b83652f93ac3af140e'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:32:11.899 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq type='result' id='6bf8b1fd3bd265b83652f93ac3af140e'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:32:11.899 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<presence/>
*** User 2022-01-27 12:32:11.992 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en'/>
*** User 2022-01-27 12:32:11.992 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 12:32:11.993 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3335fa9e4fdac84c' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:32:11.993 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:features>
<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
<mechanism>SCRAM-SHA-256</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 12:32:11.993 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9tZXNzYWdlc19maWx0ZXJlZF93aGVuX3ByZWZzX2RlZmF1bHRfcG9saWN5X2lzX3Jvc3Rlcl8xMTUwAG1ha3JvbGlrYQ==</auth>
*** User 2022-01-27 12:32:11.994 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 12:32:11.994 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 12:32:11.994 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='46f127c7c04d3e11' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:32:11.995 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:features>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 12:32:11.995 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='93546a597eabf6d29773a637517f461a'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 12:32:11.995 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq id='93546a597eabf6d29773a637517f461a' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1</jid>
</bind>
</iq>
*** User 2022-01-27 12:32:11.995 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='52b6a4934e1e281929726a6c90b22a2a'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:32:11.995 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq type='result' id='52b6a4934e1e281929726a6c90b22a2a'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:32:11.995 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<presence/>
*** User 2022-01-27 12:32:12.013 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en'/>
*** User 2022-01-27 12:32:12.014 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 12:32:12.014 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='07c03c40d3859a55' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:32:12.014 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:features>
<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
<mechanism>SCRAM-SHA-256</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 12:32:12.015 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGthdGVfbWVzc2FnZXNfZmlsdGVyZWRfd2hlbl9wcmVmc19kZWZhdWx0X3BvbGljeV9pc19yb3N0ZXJfMTE1MABtYWtyb3dlO3A=</auth>
*** User 2022-01-27 12:32:12.016 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 12:32:12.016 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-27 12:32:12.016 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='23f24f37b3890b17' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:32:12.017 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<stream:features>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-01-27 12:32:12.017 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='41b29864f3aecc5ddd147023666dadf2'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 12:32:12.017 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq id='41b29864f3aecc5ddd147023666dadf2' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1</jid>
</bind>
</iq>
*** User 2022-01-27 12:32:12.017 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='d9f520567fd40881355a5284caae3a81'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:32:12.017 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq type='result' id='d9f520567fd40881355a5284caae3a81'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:32:12.017 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<presence/>
*** User 2022-01-27 12:32:12.022 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<presence from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en'/>
*** User 2022-01-27 12:32:12.022 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<presence type='subscribe' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
*** User 2022-01-27 12:32:12.030 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='push992d368448b42fa9' type='set'>
<query xmlns='jabber:iq:roster'>
<item ask='subscribe' subscription='none' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:32:12.030 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='subscribe'/>
*** User 2022-01-27 12:32:12.030 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<presence type='subscribed' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
*** User 2022-01-27 12:32:12.039 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='push7af485abe5cd0b2e' type='set'>
<query xmlns='jabber:iq:roster'>
<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:32:12.039 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='subscribed'/>
*** User 2022-01-27 12:32:12.039 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en'/>
*** User 2022-01-27 12:32:12.039 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='pushf3632208cd0bb1a1' type='set'>
<query xmlns='jabber:iq:roster'>
<item subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:32:12.039 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<presence type='subscribe' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
*** User 2022-01-27 12:32:12.047 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='push5efcd7d9b32c6e0f' type='set'>
<query xmlns='jabber:iq:roster'>
<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:32:12.047 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='subscribe'/>
*** User 2022-01-27 12:32:12.047 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='push83cb8329abfa01a1' type='set'>
<query xmlns='jabber:iq:roster'>
<item ask='subscribe' subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:32:12.047 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<presence type='subscribed' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
*** User 2022-01-27 12:32:12.053 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='push6615c7407c15512a' type='set'>
<query xmlns='jabber:iq:roster'>
<item subscription='both' jid='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:32:12.054 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='pushfaaa4e406043af00' type='set'>
<query xmlns='jabber:iq:roster'>
<item subscription='both' jid='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:32:12.054 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='subscribed'/>
*** User 2022-01-27 12:32:12.054 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en'/>
*** User 2022-01-27 12:32:12.054 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='b9d9f834f2214db6bc14660535a15255'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always/>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.059 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='b9d9f834f2214db6bc14660535a15255' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always/>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.059 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[],[]}, now={1643,286732,59846}</body>
</message>
*** User 2022-01-27 12:32:12.060 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[],[]}, now={1643,286732,59859}</body>
</message>
*** User 2022-01-27 12:32:12.060 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=3, prefs={roster,[],[]}, now={1643,286732,59865}</body>
</message>
*** User 2022-01-27 12:32:12.060 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=4, prefs={roster,[],[]}, now={1643,286732,59895}</body>
</message>
*** User 2022-01-27 12:32:12.071 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={roster,[],[]}, now={1643,286732,59859}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7MS2AO1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.079 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={roster,[],[]}, now={1643,286732,59895}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7MV4881' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.079 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={roster,[],[]}, now={1643,286732,59846}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7MS2B01' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.079 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={roster,[],[]}, now={1643,286732,59865}</body>
</message>
*** User 2022-01-27 12:32:12.079 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='d9b21d24648ccff023f4d03ddc2e1431'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always>
<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.082 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='d9b21d24648ccff023f4d03ddc2e1431' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always>
<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.082 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[bob],[]}, now={1643,286732,82703}</body>
</message>
*** User 2022-01-27 12:32:12.082 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[bob],[]}, now={1643,286732,82714}</body>
</message>
*** User 2022-01-27 12:32:12.082 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=3, prefs={roster,[bob],[]}, now={1643,286732,82719}</body>
</message>
*** User 2022-01-27 12:32:12.083 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=4, prefs={roster,[bob],[]}, now={1643,286732,82723}</body>
</message>
*** User 2022-01-27 12:32:12.142 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={roster,[bob],[]}, now={1643,286732,82714}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NDNL01' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.146 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={roster,[bob],[]}, now={1643,286732,82723}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NF18G1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.146 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={roster,[bob],[]}, now={1643,286732,82719}</body>
</message>
*** User 2022-01-27 12:32:12.146 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={roster,[bob],[]}, now={1643,286732,82703}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NDNL81' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.146 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='6d110fe12377225538ef2d8e200aeac1'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always>
<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.148 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='6d110fe12377225538ef2d8e200aeac1' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always>
<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.148 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[kate],[]}, now={1643,286732,148596}</body>
</message>
*** User 2022-01-27 12:32:12.148 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[kate],[]}, now={1643,286732,148607}</body>
</message>
*** User 2022-01-27 12:32:12.148 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=3, prefs={roster,[kate],[]}, now={1643,286732,148612}</body>
</message>
*** User 2022-01-27 12:32:12.148 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=4, prefs={roster,[kate],[]}, now={1643,286732,148617}</body>
</message>
*** User 2022-01-27 12:32:12.159 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={roster,[kate],[]}, now={1643,286732,148607}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NHI7G1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.167 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={roster,[kate],[]}, now={1643,286732,148617}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NJDLG1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.167 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={roster,[kate],[]}, now={1643,286732,148612}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NHI701' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.167 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={roster,[kate],[]}, now={1643,286732,148596}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NHI781' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.167 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='6157d3f3a59321bec3d222574a1a03ae'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always>
<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.170 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='6157d3f3a59321bec3d222574a1a03ae' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always>
<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.170 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[kate,bob],[]}, now={1643,286732,170293}</body>
</message>
*** User 2022-01-27 12:32:12.170 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[kate,bob],[]}, now={1643,286732,170307}</body>
</message>
*** User 2022-01-27 12:32:12.170 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=3, prefs={roster,[kate,bob],[]}, now={1643,286732,170315}</body>
</message>
*** User 2022-01-27 12:32:12.170 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=4, prefs={roster,[kate,bob],[]}, now={1643,286732,170321}</body>
</message>
*** User 2022-01-27 12:32:12.179 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={roster,[kate,bob],[]}, now={1643,286732,170307}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NMBN81' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.233 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={roster,[kate,bob],[]}, now={1643,286732,170321}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NO0281' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.233 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={roster,[kate,bob],[]}, now={1643,286732,170315}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NMBNG1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.233 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={roster,[kate,bob],[]}, now={1643,286732,170293}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7NNSD01' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.233 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='1da2ceadea09341c47ad0c58a8c2079c'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always/>
<never>
<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.236 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='1da2ceadea09341c47ad0c58a8c2079c' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always/>
<never>
<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.236 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[],[bob]}, now={1643,286732,236574}</body>
</message>
*** User 2022-01-27 12:32:12.236 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[],[bob]}, now={1643,286732,236589}</body>
</message>
*** User 2022-01-27 12:32:12.236 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=3, prefs={roster,[],[bob]}, now={1643,286732,236597}</body>
</message>
*** User 2022-01-27 12:32:12.236 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=4, prefs={roster,[],[bob]}, now={1643,286732,236604}</body>
</message>
*** User 2022-01-27 12:32:12.242 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={roster,[],[bob]}, now={1643,286732,236589}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7O6I881' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.247 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={roster,[],[bob]}, now={1643,286732,236604}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7O7Q101' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.247 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={roster,[],[bob]}, now={1643,286732,236574}</body>
</message>
*** User 2022-01-27 12:32:12.247 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={roster,[],[bob]}, now={1643,286732,236597}</body>
</message>
*** User 2022-01-27 12:32:12.247 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='0eebf6c4fb169e8f761f2148550eb932'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always/>
<never>
<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.249 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='0eebf6c4fb169e8f761f2148550eb932' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always/>
<never>
<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.249 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[],[kate]}, now={1643,286732,249203}</body>
</message>
*** User 2022-01-27 12:32:12.249 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[],[kate]}, now={1643,286732,249214}</body>
</message>
*** User 2022-01-27 12:32:12.250 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=3, prefs={roster,[],[kate]}, now={1643,286732,249219}</body>
</message>
*** User 2022-01-27 12:32:12.250 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=4, prefs={roster,[],[kate]}, now={1643,286732,249225}</body>
</message>
*** User 2022-01-27 12:32:12.260 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={roster,[],[kate]}, now={1643,286732,249214}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7O9OUO1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.263 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={roster,[],[kate]}, now={1643,286732,249225}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7OC6QG1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.263 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={roster,[],[kate]}, now={1643,286732,249219}</body>
</message>
*** User 2022-01-27 12:32:12.264 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={roster,[],[kate]}, now={1643,286732,249203}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7O9OUG1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.264 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='1713a393792d29b7923d849f7fdb91ab'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always/>
<never>
<jid>bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.265 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='1713a393792d29b7923d849f7fdb91ab' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='roster'>
<always/>
<never>
<jid>bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
<jid>kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:32:12.266 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[],[bob,kate]}, now={1643,286732,265967}</body>
</message>
*** User 2022-01-27 12:32:12.266 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[],[bob,kate]}, now={1643,286732,265979}</body>
</message>
*** User 2022-01-27 12:32:12.266 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=3, prefs={roster,[],[bob,kate]}, now={1643,286732,265984}</body>
</message>
*** User 2022-01-27 12:32:12.266 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=4, prefs={roster,[],[bob,kate]}, now={1643,286732,265988}</body>
</message>
*** User 2022-01-27 12:32:12.272 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={roster,[],[bob,kate]}, now={1643,286732,265979}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7ODM4G1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:32:12.278 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={roster,[],[bob,kate]}, now={1643,286732,265988}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' id='BLKFG7OF5481' xmlns='urn:xmpp:sid:0'/>
</message>
Could not find element wait_for_parallel_writer in Config.
*** User 2022-01-27 12:32:12.278 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={roster,[],[bob,kate]}, now={1643,286732,265967}</body>
</message>
Could not find element archive_wait in Config.
*** User 2022-01-27 12:32:12.278 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={roster,[],[bob,kate]}, now={1643,286732,265984}</body>
</message>
*** User 2022-01-27 12:32:12.278 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='f894f79258d0a7bb70a33ac679a5df53'>
<query xmlns='urn:xmpp:mam:1' queryid='page_rsm'>
<x xmlns='jabber:x:data'/>
<set>
<max>50</max>
<after/>
</set>
</query>
</iq>
*** User 2022-01-27 12:32:12.284 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='a90fd971-8578-48f8-96c1-fa229466b281'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7MS29G1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[],[]}, now={1643,286732,59859}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.284 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='4a63739e-d274-4318-bfa7-1523806d4a57'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7MS2B01'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[],[]}, now={1643,286732,59846}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.284 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='c472d7c1-44f9-4e3a-83a1-0f564f04c30d'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7N0V3O1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[bob],[]}, now={1643,286732,82714}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.284 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='9dd89a38-0c3d-45c4-b6c9-699cac96938b'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7NDNL81'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[bob],[]}, now={1643,286732,82703}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.284 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='86a760ac-5eab-43bf-b7e9-6827ff99b849'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7NHI6O1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[kate],[]}, now={1643,286732,148607}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.284 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='95815079-2d98-4d63-9fbe-b19caea8bd58'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7NHI701'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=3, prefs={roster,[kate],[]}, now={1643,286732,148612}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.284 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='a7b2a919-e85d-446a-9635-654e5a9f204a'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7NHI781'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[kate],[]}, now={1643,286732,148596}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.285 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='088ba613-e4f7-4714-970c-de9977f33743'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7NJDL01'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=4, prefs={roster,[kate],[]}, now={1643,286732,148617}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.285 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='b809313a-9378-43fc-ae11-90a2edf8b6a7'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7NMBMO1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[kate,bob],[]}, now={1643,286732,170307}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.285 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='5d9ffe9a-45c9-492e-a31e-65717e05c63c'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7NMBNG1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=3, prefs={roster,[kate,bob],[]}, now={1643,286732,170315}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.285 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='923e2145-145b-4fef-a2ac-74353381f6d5'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7NNSCO1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=4, prefs={roster,[kate,bob],[]}, now={1643,286732,170321}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.285 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='6bfb2da1-f8e8-496c-a40c-8a6d9603c25d'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7NNSD01'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[kate,bob],[]}, now={1643,286732,170293}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.285 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='b209dac9-6005-4e16-a2f8-eab07cbb5154'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7O9OU81'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=2, prefs={roster,[],[kate]}, now={1643,286732,249214}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.285 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='6a5a9d92-987d-461a-9e47-2ef7d42a2918'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG7O9OUG1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:32:12Z' from='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1'/>
<message from='bob_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' type='chat'>
<body>n=1, prefs={roster,[],[kate]}, now={1643,286732,249203}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:32:12.285 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='f894f79258d0a7bb70a33ac679a5df53' type='result'>
<fin xmlns='urn:xmpp:mam:1' complete='true'>
<set xmlns='http://jabber.org/protocol/rsm'>
<first index='0'>BLKFG7MS29G1</first>
<last>BLKFG7O9OUG1</last>
<count>14</count>
</set>
</fin>
</iq>
*** User 2022-01-27 12:32:12.286 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
<iq type='set' id='c3cf642e9b69fe95f21ce407013ac771'>
<query xmlns='urn:xmpp:mam:1' queryid='page_rsm'>
<x xmlns='jabber:x:data'/>
<set>
<max>50</max>
<after>BLKFG7O9OUG1</after>
</set>
</query>
</iq>
*** User 2022-01-27 12:32:12.290 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1' id='c3cf642e9b69fe95f21ce407013ac771' type='result'>
<fin xmlns='urn:xmpp:mam:1' complete='true'>
<set xmlns='http://jabber.org/protocol/rsm'>
<count>14</count>
</set>
</fin>
</iq>
*** User 2022-01-27 12:32:12.290 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
</stream:stream>
*** User 2022-01-27 12:32:12.290 ***
kate_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
</stream:stream>
*** User 2022-01-27 12:32:12.290 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
</stream:stream>
*** User 2022-01-27 12:32:12.290 ***
bOb_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
</stream:stream>
*** User 2022-01-27 12:32:12.290 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 out
</stream:stream>
*** User 2022-01-27 12:32:12.291 ***
alicE_messages_filtered_when_prefs_default_policy_is_roster_1150@domain.example.com/res1 in
</stream:stream>
=== Ended at 2022-01-27 12:32:12
=== successfully completed test case
=== === Returned value: ok