=== Test case: mam_SUITE:messages_filtered_when_prefs_default_policy_is_always/1 (click for source code)
=== Config value:
[{basic_group,prefs_cases},
{configuration,rdbms},
{watchdog,<0.22531.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_always.30083.html"},
{tc_group_properties,[{name,rdbms_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_rdbms_arch => [],
mod_mam_rdbms_prefs => [{pm,true}],
mod_mam_rdbms_user => [{pm,true}],
mod_muc =>
[{host,{prefix,<<"groupchats.">>}},
{backend,rdbms},
{hibernate_timeout,2000},
{hibernated_room_check_interval,1000},
{hibernated_room_timeout,2000},
{access,muc},
{access_create,muc_create}],
mod_muc_commands => [],mod_muc_light_commands => [],
mod_muc_log => [{outdir,"/tmp/muclogs"},{access_log,muc}],
mod_register =>
[{access,register},
{ip_access,[{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]},
{welcome_message,{[],[]}}],
mod_roster => [{backend,rdbms}],
mod_sic => [],mod_stream_management => [],
mod_vcard => [{backend,rdbms},{host,{prefix,<<"vjud.">>}}]}},
{escalus_users,[{alice,[{username,<<"alicE">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"matygrysa">>}]},
{bob,[{username,<<"bOb">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"makrolika">>}]},
{kate,[{username,<<"kate">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"makrowe;p">>}]},
{carol,[{username,<<"carol">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"jinglebells">>},
{transport,escalus_bosh},
{path,<<"/http-bind">>},
{port,5280}]}]}]
=== Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@998557c7e1d1.2022-01-27_12.27.57"
=== Started at 2022-01-27 12:31:43
Could not find element props in Config.
*** User 2022-01-27 12:31:43.701 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.702 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='97e3c596e616f93a' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:31:43.702 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.702 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX21lc3NhZ2VzX2ZpbHRlcmVkX3doZW5fcHJlZnNfZGVmYXVsdF9wb2xpY3lfaXNfYWx3YXlzXzg5MwBtYXR5Z3J5c2E=</auth>
*** User 2022-01-27 12:31:43.703 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 12:31:43.703 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.704 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='f07b93c5e9f524ba' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:31:43.704 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.704 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='9e1512aa6c87e3e10056ee6a27c6a607'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 12:31:43.704 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq id='9e1512aa6c87e3e10056ee6a27c6a607' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1</jid>
</bind>
</iq>
*** User 2022-01-27 12:31:43.704 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='1acffa93bda4f17710306d957fde25ab'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:31:43.705 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq type='result' id='1acffa93bda4f17710306d957fde25ab'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:31:43.705 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<presence/>
*** User 2022-01-27 12:31:43.707 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en'/>
*** User 2022-01-27 12:31:43.707 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.707 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d96efe588d1c5e26' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:31:43.708 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.708 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9tZXNzYWdlc19maWx0ZXJlZF93aGVuX3ByZWZzX2RlZmF1bHRfcG9saWN5X2lzX2Fsd2F5c184OTMAbWFrcm9saWth</auth>
*** User 2022-01-27 12:31:43.709 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 12:31:43.709 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.709 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='b20c9ffa54c9d9b8' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:31:43.709 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.709 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='442121e5f5c281ad92df2c66f330d0cb'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 12:31:43.709 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq id='442121e5f5c281ad92df2c66f330d0cb' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1</jid>
</bind>
</iq>
*** User 2022-01-27 12:31:43.709 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='77b09b1a162c06fc612223fd872b0ffc'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:31:43.710 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq type='result' id='77b09b1a162c06fc612223fd872b0ffc'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:31:43.710 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<presence/>
*** User 2022-01-27 12:31:43.712 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en'/>
*** User 2022-01-27 12:31:43.712 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.712 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='308952c061e1c91a' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:31:43.713 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.713 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGthdGVfbWVzc2FnZXNfZmlsdGVyZWRfd2hlbl9wcmVmc19kZWZhdWx0X3BvbGljeV9pc19hbHdheXNfODkzAG1ha3Jvd2U7cA==</auth>
*** User 2022-01-27 12:31:43.714 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 12:31:43.714 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.714 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='916adb168be88469' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-01-27 12:31:43.714 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@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:31:43.714 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='47f46db758efeedc66433276a449052d'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 12:31:43.714 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq id='47f46db758efeedc66433276a449052d' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1</jid>
</bind>
</iq>
*** User 2022-01-27 12:31:43.714 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='86929d02519d5f6c4bfdcb4790274ad7'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:31:43.715 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq type='result' id='86929d02519d5f6c4bfdcb4790274ad7'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 12:31:43.715 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<presence/>
*** User 2022-01-27 12:31:43.719 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<presence from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en'/>
*** User 2022-01-27 12:31:43.719 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<presence type='subscribe' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
*** User 2022-01-27 12:31:43.739 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='push80e51e5ba43743a1' type='set'>
<query xmlns='jabber:iq:roster'>
<item ask='subscribe' subscription='none' jid='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:31:43.740 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='subscribe'/>
*** User 2022-01-27 12:31:43.740 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<presence type='subscribed' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
*** User 2022-01-27 12:31:43.761 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='pushd31e0ba0abc033ff' type='set'>
<query xmlns='jabber:iq:roster'>
<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:31:43.761 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='subscribed'/>
*** User 2022-01-27 12:31:43.761 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en'/>
*** User 2022-01-27 12:31:43.761 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='push90fb1d3e8dfd344d' type='set'>
<query xmlns='jabber:iq:roster'>
<item subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:31:43.761 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<presence type='subscribe' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
*** User 2022-01-27 12:31:43.797 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='push399534464feb4172' type='set'>
<query xmlns='jabber:iq:roster'>
<item subscription='to' jid='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:31:43.797 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<presence from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='subscribe'/>
*** User 2022-01-27 12:31:43.797 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='push81b9cab582e17647' type='set'>
<query xmlns='jabber:iq:roster'>
<item ask='subscribe' subscription='from' jid='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:31:43.797 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<presence type='subscribed' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
*** User 2022-01-27 12:31:43.816 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='push7b19e0e1b89f85a4' type='set'>
<query xmlns='jabber:iq:roster'>
<item subscription='both' jid='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:31:43.816 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='push44295844664a4477' type='set'>
<query xmlns='jabber:iq:roster'>
<item subscription='both' jid='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com'/>
</query>
</iq>
*** User 2022-01-27 12:31:43.816 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='subscribed'/>
*** User 2022-01-27 12:31:43.816 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<presence from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en'/>
*** User 2022-01-27 12:31:43.816 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='521ce8eaa2691d66928e8906b67af75b'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always/>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:31:43.906 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='521ce8eaa2691d66928e8906b67af75b' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always/>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:31:43.906 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[],[]}, now={1643,286703,906391}</body>
</message>
*** User 2022-01-27 12:31:43.906 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[],[]}, now={1643,286703,906401}</body>
</message>
*** User 2022-01-27 12:31:43.906 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[],[]}, now={1643,286703,906406}</body>
</message>
*** User 2022-01-27 12:31:43.906 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[],[]}, now={1643,286703,906410}</body>
</message>
*** User 2022-01-27 12:31:44.064 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={always,[],[]}, now={1643,286703,906401}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG101VPO1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.147 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={always,[],[]}, now={1643,286703,906410}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG11ER601' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.147 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={always,[],[]}, now={1643,286703,906406}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG10KJN81' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.147 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={always,[],[]}, now={1643,286703,906391}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG10KJNO1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.147 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='13281d1f35b222ecc6fbbf592cfe91fb'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always>
<jid>bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.189 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='13281d1f35b222ecc6fbbf592cfe91fb' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always>
<jid>bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.189 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[bob],[]}, now={1643,286704,189511}</body>
</message>
*** User 2022-01-27 12:31:44.189 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[bob],[]}, now={1643,286704,189528}</body>
</message>
*** User 2022-01-27 12:31:44.189 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[bob],[]}, now={1643,286704,189535}</body>
</message>
*** User 2022-01-27 12:31:44.189 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[bob],[]}, now={1643,286704,189542}</body>
</message>
*** User 2022-01-27 12:31:44.239 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={always,[bob],[]}, now={1643,286704,189528}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG1274281' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.271 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={always,[bob],[]}, now={1643,286704,189542}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG12JB281' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.272 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={always,[bob],[]}, now={1643,286704,189511}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG1272NO1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.272 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={always,[bob],[]}, now={1643,286704,189535}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG12J5MO1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.272 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='913a463387f4fb7f8afe4b001abba5f1'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always>
<jid>kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.277 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='913a463387f4fb7f8afe4b001abba5f1' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always>
<jid>kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.277 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[kate],[]}, now={1643,286704,277563}</body>
</message>
*** User 2022-01-27 12:31:44.277 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[kate],[]}, now={1643,286704,277574}</body>
</message>
*** User 2022-01-27 12:31:44.277 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[kate],[]}, now={1643,286704,277579}</body>
</message>
*** User 2022-01-27 12:31:44.277 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[kate],[]}, now={1643,286704,277584}</body>
</message>
*** User 2022-01-27 12:31:44.297 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={always,[kate],[]}, now={1643,286704,277574}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG12SJ4O1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.316 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={always,[kate],[]}, now={1643,286704,277584}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG134V4G1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.316 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={always,[kate],[]}, now={1643,286704,277579}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG12SJ501' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.316 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={always,[kate],[]}, now={1643,286704,277563}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG12SJ5G1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.316 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='184d19a911f5e9a9af9f19baaaf2d7e8'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always>
<jid>kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
<jid>bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.330 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='184d19a911f5e9a9af9f19baaaf2d7e8' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always>
<jid>kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
<jid>bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</always>
<never/>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.330 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[kate,bob],[]}, now={1643,286704,330655}</body>
</message>
*** User 2022-01-27 12:31:44.330 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[kate,bob],[]}, now={1643,286704,330671}</body>
</message>
*** User 2022-01-27 12:31:44.330 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[kate,bob],[]}, now={1643,286704,330679}</body>
</message>
*** User 2022-01-27 12:31:44.331 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[kate,bob],[]}, now={1643,286704,330687}</body>
</message>
*** User 2022-01-27 12:31:44.341 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={always,[kate,bob],[]}, now={1643,286704,330671}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG139ID81' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.355 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={always,[kate,bob],[]}, now={1643,286704,330687}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG13DLI81' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.355 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={always,[kate,bob],[]}, now={1643,286704,330679}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG139IE81' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.355 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={always,[kate,bob],[]}, now={1643,286704,330655}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG139IDO1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.355 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='1086f82105d290937f36073c5aa75834'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always/>
<never>
<jid>bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.359 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='1086f82105d290937f36073c5aa75834' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always/>
<never>
<jid>bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.359 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[],[bob]}, now={1643,286704,359729}</body>
</message>
*** User 2022-01-27 12:31:44.359 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[],[bob]}, now={1643,286704,359740}</body>
</message>
*** User 2022-01-27 12:31:44.359 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[],[bob]}, now={1643,286704,359745}</body>
</message>
*** User 2022-01-27 12:31:44.359 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[],[bob]}, now={1643,286704,359750}</body>
</message>
*** User 2022-01-27 12:31:44.370 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={always,[],[bob]}, now={1643,286704,359740}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG13GLMO1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.390 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={always,[],[bob]}, now={1643,286704,359750}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG13MDF01' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.390 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={always,[],[bob]}, now={1643,286704,359745}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG13GLNG1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.390 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={always,[],[bob]}, now={1643,286704,359729}</body>
</message>
*** User 2022-01-27 12:31:44.391 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='a21570e7eb89d8a3fa3f5e99cdaf2f3e'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always/>
<never>
<jid>kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.396 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='a21570e7eb89d8a3fa3f5e99cdaf2f3e' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always/>
<never>
<jid>kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.396 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[],[kate]}, now={1643,286704,396475}</body>
</message>
*** User 2022-01-27 12:31:44.396 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[],[kate]}, now={1643,286704,396487}</body>
</message>
*** User 2022-01-27 12:31:44.396 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[],[kate]}, now={1643,286704,396492}</body>
</message>
*** User 2022-01-27 12:31:44.396 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[],[kate]}, now={1643,286704,396496}</body>
</message>
*** User 2022-01-27 12:31:44.447 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={always,[],[kate]}, now={1643,286704,396487}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG13PK281' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.469 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={always,[],[kate]}, now={1643,286704,396496}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG1463381' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.469 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={always,[],[kate]}, now={1643,286704,396492}</body>
</message>
*** User 2022-01-27 12:31:44.469 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={always,[],[kate]}, now={1643,286704,396475}</body>
<stanza-id by='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG13PK2G1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.470 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='dcdce14cb7c812d0469e716dd17aa82d'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always/>
<never>
<jid>bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
<jid>kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.474 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='dcdce14cb7c812d0469e716dd17aa82d' type='result'>
<prefs xmlns='urn:xmpp:mam:1' default='always'>
<always/>
<never>
<jid>bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
<jid>kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com</jid>
</never>
</prefs>
</iq>
*** User 2022-01-27 12:31:44.475 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[],[bob,kate]}, now={1643,286704,475002}</body>
</message>
*** User 2022-01-27 12:31:44.475 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[],[bob,kate]}, now={1643,286704,475014}</body>
</message>
*** User 2022-01-27 12:31:44.475 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[],[bob,kate]}, now={1643,286704,475019}</body>
</message>
*** User 2022-01-27 12:31:44.475 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<message to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[],[bob,kate]}, now={1643,286704,475023}</body>
</message>
*** User 2022-01-27 12:31:44.485 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=2, prefs={always,[],[bob,kate]}, now={1643,286704,475014}</body>
<stanza-id by='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG14CPH01' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.486 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=4, prefs={always,[],[bob,kate]}, now={1643,286704,475023}</body>
<stanza-id by='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' id='BLKFG14DVQG1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 12:31:44.486 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=1, prefs={always,[],[bob,kate]}, now={1643,286704,475002}</body>
</message>
Could not find element wait_for_parallel_writer in Config.
*** User 2022-01-27 12:31:44.486 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xml:lang='en' type='chat'>
<body>n=3, prefs={always,[],[bob,kate]}, now={1643,286704,475019}</body>
</message>
Could not find element archive_wait in Config.
*** User 2022-01-27 12:31:44.486 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='c2e0427ebbc793b77bef3c02ac0fd7bb'>
<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:31:44.489 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='68f2b9f2-8248-4f70-bf51-70054ee9442a'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG101VP01'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:43Z' from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[],[]}, now={1643,286703,906401}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.489 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='ae1e7a18-b504-4bd5-87ad-13c3cad31454'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG10KJN81'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:43Z' from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[],[]}, now={1643,286703,906406}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='9df28848-2831-40a0-a4b4-95ea1d6731b0'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG10KJNO1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:43Z' from='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[],[]}, now={1643,286703,906391}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='359ace0d-6c1d-4b6b-ab9b-f45c3837adab'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG10OM6O1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:43Z' from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[],[]}, now={1643,286703,906410}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='78573fb3-3721-4869-997b-19248ef65f42'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG1272NO1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[bob],[]}, now={1643,286704,189511}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='1d472a73-e91b-4b9d-8866-8cbaa1e5f664'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG1273K81'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[bob],[]}, now={1643,286704,189528}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='3ba96fa2-a466-4c1a-94be-0f3d1713ad70'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG12J5MG1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[bob],[]}, now={1643,286704,189542}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='8fb73f85-8f11-4f2e-a044-19d7df1897d0'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG12J5MO1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[bob],[]}, now={1643,286704,189535}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='dc55d8b2-ed91-469f-a1f4-c75d63851cd9'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG12SIPG1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[kate],[]}, now={1643,286704,277574}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='687cf6f6-5992-49f0-8249-2399b9fe5e55'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG12SJ501'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[kate],[]}, now={1643,286704,277579}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='340c490c-7275-4856-b49f-14ab8f273197'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG12SJ5G1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[kate],[]}, now={1643,286704,277563}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='0e483f6b-9323-4ba3-9c0b-a4adb7efeb70'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG130U701'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[kate],[]}, now={1643,286704,277584}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='9b9f50ff-79e7-4a15-aeee-e0c18284cd90'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG139HSG1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[kate,bob],[]}, now={1643,286704,330671}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='aceaed6f-cbbb-4467-babc-3e0abf3ea205'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG139IDO1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[kate,bob],[]}, now={1643,286704,330655}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.490 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='2c102daa-b938-4e21-9228-1bcf5cd4d05e'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG139IE81'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[kate,bob],[]}, now={1643,286704,330679}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.491 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='c3507548-7548-4899-aa53-0a4ba8e5bb33'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG13C2FO1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[kate,bob],[]}, now={1643,286704,330687}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.491 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='6a5ef364-0e4d-44ee-85d1-56f622992672'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG13GLNG1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=3, prefs={always,[],[bob]}, now={1643,286704,359745}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.491 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='33aa7fb2-617c-4edc-98be-ad0ef4b6730d'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG13IC1O1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=4, prefs={always,[],[bob]}, now={1643,286704,359750}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.491 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='7b611274-aaff-4b2f-a678-e0c7f8f21406'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG13PJG81'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='alice_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=2, prefs={always,[],[kate]}, now={1643,286704,396487}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.491 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<message from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='143dceab-2a66-4e71-a1be-23d6212c8e08'>
<result queryid='page_rsm' xmlns='urn:xmpp:mam:1' id='BLKFG13PK2G1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T12:31:44Z' from='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1'/>
<message from='bob_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' type='chat'>
<body>n=1, prefs={always,[],[kate]}, now={1643,286704,396475}</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 12:31:44.491 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='c2e0427ebbc793b77bef3c02ac0fd7bb' type='result'>
<fin xmlns='urn:xmpp:mam:1' complete='true'>
<set xmlns='http://jabber.org/protocol/rsm'>
<first index='0'>BLKFG101VP01</first>
<last>BLKFG13PK2G1</last>
<count>20</count>
</set>
</fin>
</iq>
*** User 2022-01-27 12:31:44.491 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
<iq type='set' id='1c60994943299bd88e9b4e618dc05713'>
<query xmlns='urn:xmpp:mam:1' queryid='page_rsm'>
<x xmlns='jabber:x:data'/>
<set>
<max>50</max>
<after>BLKFG13PK2G1</after>
</set>
</query>
</iq>
*** User 2022-01-27 12:31:44.494 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
<iq from='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com' to='alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1' id='1c60994943299bd88e9b4e618dc05713' type='result'>
<fin xmlns='urn:xmpp:mam:1' complete='true'>
<set xmlns='http://jabber.org/protocol/rsm'>
<count>20</count>
</set>
</fin>
</iq>
*** User 2022-01-27 12:31:44.495 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
</stream:stream>
*** User 2022-01-27 12:31:44.495 ***
kate_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
</stream:stream>
*** User 2022-01-27 12:31:44.495 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
</stream:stream>
*** User 2022-01-27 12:31:44.495 ***
bOb_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
</stream:stream>
*** User 2022-01-27 12:31:44.495 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 out
</stream:stream>
*** User 2022-01-27 12:31:44.496 ***
alicE_messages_filtered_when_prefs_default_policy_is_always_893@domain.example.com/res1 in
</stream:stream>
=== Ended at 2022-01-27 12:31:44
=== successfully completed test case
=== === Returned value: ok