=== Test case: mam_SUITE:archive_is_instrumented/1 (click for source code)
=== Config value:
[{props,[{mam_ns,<<"urn:xmpp:mam:1">>}]},
{watchdog,<0.47007.0>},
{basic_group,mam_all},
{configuration,rdbms_async_pool},
{wait_for_parallel_writer,[pm]},
{mam_meta_opts,#{cache =>
#{module => internal,strategy => fifo,
number_of_segments => 3,time_to_live => 480},
backend => rdbms,send_message => mod_mam_utils,
max_result_limit => 50,
pm =>
#{archive_groupchats => false,
same_mam_id_for_peers => false},
async_writer =>
#{enabled => true,pool_size => 16,batch_size => 30,
flush_interval => 1},
is_archivable_message => mod_mam_utils,
archive_chat_markers => false,full_text_search => true,
message_retraction => true,default_result_limit => 50,
enforce_simple_queries => false,
no_stanzaid_element => false,user_prefs_store => rdbms,
cache_users => false}},
{mod_offline_loaded,false},
{escalus_user_db,{module,escalus_ejabberd}},
{preset,"pgsql_mnesia"},
{mim_data_dir,"/home/circleci/project/big_tests/tests/mam_SUITE_data"},
{tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@62ff1c7eec89.2024-04-23_06.46.53/big_tests.tests.mam_SUITE.logs/run.2024-04-23_06.55.16/mam_suite.archive_is_instrumented.38917.html"},
{tc_group_properties,[{name,mam04},parallel]},
{tc_group_path,[[{name,rdbms_async_pool_mam_all},parallel]]},
{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@62ff1c7eec89.2024-04-23_06.46.53/big_tests.tests.mam_SUITE.logs/run.2024-04-23_06.55.16/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,[#{value => 10,acl => all}]}}},
{{saved_modules,mongooseim@localhost,<<"test type">>},
#{mod_vcard =>
#{matches => 30,
host => {prefix,<<"vjud.">>},
search => true,iqdisc => parallel,backend => rdbms},
mod_roster =>
#{iqdisc => one_queue,backend => rdbms,versioning => false,
store_current_id => false},
mod_muc =>
#{access => muc,
host => {prefix,<<"groupchats.">>},
backend => rdbms,max_users => 200,room_shaper => none,
http_auth_pool => none,hibernate_timeout => 2000,
history_size => 20,hibernated_room_check_interval => 1000,
hibernated_room_timeout => 2000,access_create => muc_create,
access_admin => none,access_persistent => all,
default_room =>
#{public => true,description => <<>>,persistent => false,
title => <<>>,password => <<>>,anonymous => true,
allow_change_subj => true,allow_query_users => true,
allow_private_messages => true,
allow_visitor_status => true,
allow_visitor_nickchange => true,public_list => true,
moderated => true,members_by_default => true,
members_only => false,allow_user_invites => false,
allow_multiple_sessions => false,
password_protected => false,max_users => 200,
maygetmemberlist => [],logging => false,
affiliations => [],subject => <<>>,subject_author => <<>>},
load_permanent_rooms_at_startup => false,
max_room_id => infinity,online_backend => mnesia,
min_presence_interval => 0,max_users_admin_threshold => 5,
user_message_shaper => none,user_presence_shaper => none,
min_message_interval => 0,max_user_conferences => 10,
max_room_name => infinity,max_room_desc => infinity},
mod_register =>
#{access => register,iqdisc => one_queue,
registration_watchers => [],password_strength => 0,
ip_access => [{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]},
mod_sic => #{iqdisc => one_queue},
mod_amp => #{},
mod_disco =>
#{iqdisc => one_queue,server_info => [],extra_domains => [],
users_can_see_hidden_services => false},
mod_presence => #{},
mod_muc_log =>
#{dirname => room_jid,outdir => "/tmp/muclogs",
file_format => html,css_file => false,timezone => local,
spam_prevention => true,
top_link => {"/","Home"},
access_log => muc,dirtype => subdirs},
mod_stream_management =>
#{buffer => true,ack => true,backend => mnesia,
stale_h =>
#{enabled => false,repeat_after => 1800,geriatric => 3600},
buffer_max => 100,ack_freq => 1,resume_timeout => 600},
mod_adhoc => #{iqdisc => one_queue,report_commands_node => false},
mod_bosh =>
#{backend => mnesia,inactivity => 30,max_pause => 120,
max_wait => infinity,server_acks => false},
mod_carboncopy => #{iqdisc => no_queue},
mod_cache_users =>
#{strategy => fifo,number_of_segments => 5,time_to_live => 2}}},
{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@62ff1c7eec89.2024-04-23_06.46.53"
=== Started at 2024-04-23 06:55:39
*** User 2024-04-23 06:55:39.725 ***🔗 alicE_archive_is_instrumented_1972@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 2024-04-23 06:55:39.727 ***🔗 alicE_archive_is_instrumented_1972@domain.example.com/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='55f785da570eae9f' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2024-04-23 06:55:39.727 ***🔗 alicE_archive_is_instrumented_1972@domain.example.com/res1 in <stream:features> <register xmlns='http://jabber.org/features/iq-register'/> <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/> <mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'> <mechanism>SCRAM-SHA-256</mechanism> <mechanism>PLAIN</mechanism> </mechanisms> <amp xmlns='http://jabber.org/feature/amp'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2024-04-23 06:55:39.727 ***🔗 alicE_archive_is_instrumented_1972@domain.example.com/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX2FyY2hpdmVfaXNfaW5zdHJ1bWVudGVkXzE5NzIAbWF0eWdyeXNh</auth>
*** User 2024-04-23 06:55:39.729 ***🔗 alicE_archive_is_instrumented_1972@domain.example.com/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-23 06:55:39.730 ***🔗 alicE_archive_is_instrumented_1972@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 2024-04-23 06:55:39.730 ***🔗 alicE_archive_is_instrumented_1972@domain.example.com/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d3a56cf9e2ce802a' from='domain.example.com' version='1.0' xml:lang='en' to='alice_archive_is_instrumented_1972@domain.example.com'>
*** User 2024-04-23 06:55:39.730 ***🔗 alicE_archive_is_instrumented_1972@domain.example.com/res1 in <stream:features> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/> <register xmlns='http://jabber.org/features/iq-register'/> <amp xmlns='http://jabber.org/feature/amp'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2024-04-23 06:55:39.730 ***🔗 alicE_archive_is_instrumented_1972@domain.example.com/res1 out <iq type='set' id='e56652b88892e1b109a228765024d357'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2024-04-23 06:55:39.731 ***🔗 alicE_archive_is_instrumented_1972@domain.example.com/res1 in <iq id='e56652b88892e1b109a228765024d357' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alice_archive_is_instrumented_1972@domain.example.com/res1</jid> </bind> </iq>
*** User 2024-04-23 06:55:39.732 ***🔗 alice_archive_is_instrumented_1972@domain.example.com/res1 out <iq type='set' id='823ebc8633f74c5ae5f268aae771bd3f'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-23 06:55:39.732 ***🔗 alice_archive_is_instrumented_1972@domain.example.com/res1 in <iq from='domain.example.com' to='alice_archive_is_instrumented_1972@domain.example.com/res1' id='823ebc8633f74c5ae5f268aae771bd3f' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-23 06:55:39.732 ***🔗 alice_archive_is_instrumented_1972@domain.example.com/res1 out <presence/>
*** User 2024-04-23 06:55:39.734 ***🔗 alice_archive_is_instrumented_1972@domain.example.com/res1 in <presence from='alice_archive_is_instrumented_1972@domain.example.com/res1' to='alice_archive_is_instrumented_1972@domain.example.com/res1'/>
*** User 2024-04-23 06:55:39.738 ***🔗 bOb_archive_is_instrumented_1972@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 2024-04-23 06:55:39.738 ***🔗 bOb_archive_is_instrumented_1972@domain.example.com/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='21c8777b7ca491fe' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2024-04-23 06:55:39.739 ***🔗 bOb_archive_is_instrumented_1972@domain.example.com/res1 in <stream:features> <register xmlns='http://jabber.org/features/iq-register'/> <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/> <mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'> <mechanism>SCRAM-SHA-256</mechanism> <mechanism>PLAIN</mechanism> </mechanisms> <amp xmlns='http://jabber.org/feature/amp'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2024-04-23 06:55:39.739 ***🔗 bOb_archive_is_instrumented_1972@domain.example.com/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9hcmNoaXZlX2lzX2luc3RydW1lbnRlZF8xOTcyAG1ha3JvbGlrYQ==</auth>
*** User 2024-04-23 06:55:39.741 ***🔗 bOb_archive_is_instrumented_1972@domain.example.com/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-23 06:55:39.741 ***🔗 bOb_archive_is_instrumented_1972@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 2024-04-23 06:55:39.742 ***🔗 bOb_archive_is_instrumented_1972@domain.example.com/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='cdb085f50baa2432' from='domain.example.com' version='1.0' xml:lang='en' to='bob_archive_is_instrumented_1972@domain.example.com'>
*** User 2024-04-23 06:55:39.742 ***🔗 bOb_archive_is_instrumented_1972@domain.example.com/res1 in <stream:features> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/> <register xmlns='http://jabber.org/features/iq-register'/> <amp xmlns='http://jabber.org/feature/amp'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2024-04-23 06:55:39.742 ***🔗 bOb_archive_is_instrumented_1972@domain.example.com/res1 out <iq type='set' id='453c4ee8bf1cdb27cf03f16aad90b380'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2024-04-23 06:55:39.743 ***🔗 bOb_archive_is_instrumented_1972@domain.example.com/res1 in <iq id='453c4ee8bf1cdb27cf03f16aad90b380' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>bob_archive_is_instrumented_1972@domain.example.com/res1</jid> </bind> </iq>
*** User 2024-04-23 06:55:39.743 ***🔗 bob_archive_is_instrumented_1972@domain.example.com/res1 out <iq type='set' id='10eae20a62c10d5c636a62393f0e25c5'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-23 06:55:39.744 ***🔗 bob_archive_is_instrumented_1972@domain.example.com/res1 in <iq from='domain.example.com' to='bob_archive_is_instrumented_1972@domain.example.com/res1' id='10eae20a62c10d5c636a62393f0e25c5' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-23 06:55:39.744 ***🔗 bob_archive_is_instrumented_1972@domain.example.com/res1 out <presence/>
*** User 2024-04-23 06:55:39.799 ***🔗 bob_archive_is_instrumented_1972@domain.example.com/res1 in <presence from='bob_archive_is_instrumented_1972@domain.example.com/res1' to='bob_archive_is_instrumented_1972@domain.example.com/res1'/>
*** User 2024-04-23 06:55:39.799 ***🔗 alice_archive_is_instrumented_1972@domain.example.com/res1 out <message type='chat' to='bob_archive_is_instrumented_1972@domain.example.com/res1'> <body>OH, HAI!</body> </message>
*** User 2024-04-23 06:55:39.815 ***🔗 bob_archive_is_instrumented_1972@domain.example.com/res1 in <message from='alice_archive_is_instrumented_1972@domain.example.com/res1' to='bob_archive_is_instrumented_1972@domain.example.com/res1' type='chat'> <body>OH, HAI!</body> <stanza-id by='bob_archive_is_instrumented_1972@domain.example.com' id='C5LU1ASQJRG1' xmlns='urn:xmpp:sid:0'/> </message>
*** User 2024-04-23 06:55:39.844 ***🔗 Matching events: [{{mod_mam_pm_archive_message, #{host_type => <<"test type">>}}, #{count => 1,time => 11, params => #{packet => {xmlel,<<"message">>, [{<<"type">>,<<"chat">>}, {<<"to">>, <<"bob_archive_is_instrumented_1972@domain.example.com/res1">>}], [{xmlel,<<"body">>,[],[{xmlcdata,<<"OH, HAI!">>}]}]}, direction => outgoing,archive_id => 773, origin_id => none,message_id => 438746966988965889, source_jid => {jid,<<"alice_archive_is_instrumented_1972">>, <<"domain.example.com">>,<<"res1">>}, remote_jid => {jid,<<"bob_archive_is_instrumented_1972">>, <<"domain.example.com">>,<<"res1">>}, local_jid => {jid,<<"alice_archive_is_instrumented_1972">>, <<"domain.example.com">>,<<"res1">>}, is_groupchat => false}}}]
*** User 2024-04-23 06:55:39.904 ***🔗 waiting for archive_size is done in 0 miliseconds
*** User 2024-04-23 06:55:39.905 ***🔗 Matching events: [{{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 736,time_per_message => 736}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 959,time_per_message => 959}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 646,time_per_message => 646}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 502,time_per_message => 502}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 925,time_per_message => 463}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 556,time_per_message => 556}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 519,time_per_message => 519}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 1315,time_per_message => 658}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 538,time_per_message => 538}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 633,time_per_message => 633}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 773,time_per_message => 773}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 459,time_per_message => 459}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 593,time_per_message => 593}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 682,time_per_message => 682}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 1032,time_per_message => 516}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 775,time_per_message => 775}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 683,time_per_message => 683}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 973,time_per_message => 487}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 565,time_per_message => 565}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 926,time_per_message => 926}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 759,time_per_message => 759}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 507,time_per_message => 507}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 529,time_per_message => 529}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 1074,time_per_message => 537}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 860,time_per_message => 860}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 467,time_per_message => 467}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 732,time_per_message => 732}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 598,time_per_message => 598}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 4,time => 2081,time_per_message => 520}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 651,time_per_message => 651}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 691,time_per_message => 691}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 737,time_per_message => 737}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 547,time_per_message => 547}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 792,time_per_message => 792}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 4,time => 2148,time_per_message => 537}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 658,time_per_message => 658}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 663,time_per_message => 663}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 840,time_per_message => 840}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 3,time => 2607,time_per_message => 869}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1266,time_per_message => 1266}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 541,time_per_message => 541}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 754,time_per_message => 754}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 546,time_per_message => 546}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 4,time => 3216,time_per_message => 804}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 500,time_per_message => 500}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 781,time_per_message => 781}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 585,time_per_message => 585}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 4,time => 3251,time_per_message => 813}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 562,time_per_message => 562}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 669,time_per_message => 669}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 542,time_per_message => 542}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1190,time_per_message => 1190}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 4,time => 3487,time_per_message => 872}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 675,time_per_message => 675}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1326,time_per_message => 1326}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 571,time_per_message => 571}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 883,time_per_message => 883}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 492,time_per_message => 492}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1316,time_per_message => 1316}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2864,time_per_message => 2864}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2271,time_per_message => 2271}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 4,time => 5005,time_per_message => 1251}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1069,time_per_message => 1069}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1001,time_per_message => 1001}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1780,time_per_message => 1780}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1489,time_per_message => 1489}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1138,time_per_message => 1138}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2344,time_per_message => 2344}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2743,time_per_message => 2743}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1478,time_per_message => 1478}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1123,time_per_message => 1123}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1262,time_per_message => 1262}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 4,time => 54683,time_per_message => 13671}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1845,time_per_message => 1845}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1908,time_per_message => 1908}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1982,time_per_message => 1982}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1408,time_per_message => 1408}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2217,time_per_message => 2217}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 4976,time_per_message => 2488}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 3,time => 7355,time_per_message => 2452}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2495,time_per_message => 2495}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1991,time_per_message => 1991}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1265,time_per_message => 1265}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1951,time_per_message => 1951}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1768,time_per_message => 1768}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1292,time_per_message => 1292}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 724,time_per_message => 724}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1173,time_per_message => 1173}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2668,time_per_message => 2668}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 5,time => 5827,time_per_message => 1165}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 4,time => 6752,time_per_message => 1688}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1402,time_per_message => 1402}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1053,time_per_message => 1053}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1459,time_per_message => 1459}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1389,time_per_message => 1389}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1519,time_per_message => 1519}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 4287,time_per_message => 2144}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1548,time_per_message => 1548}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1320,time_per_message => 1320}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 2826,time_per_message => 1413}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 590,time_per_message => 590}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1378,time_per_message => 1378}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 2232,time_per_message => 1116}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 3105,time_per_message => 1553}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1058,time_per_message => 1058}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1619,time_per_message => 1619}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1733,time_per_message => 1733}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1066,time_per_message => 1066}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 612,time_per_message => 612}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 491,time_per_message => 491}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 1884,time_per_message => 942}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 599,time_per_message => 599}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 799,time_per_message => 799}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 2,time => 1278,time_per_message => 639}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 644,time_per_message => 644}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1313,time_per_message => 1313}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1735,time_per_message => 1735}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2360,time_per_message => 2360}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2216,time_per_message => 2216}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1657,time_per_message => 1657}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 671,time_per_message => 671}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 961,time_per_message => 961}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1012,time_per_message => 1012}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 665,time_per_message => 665}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1298,time_per_message => 1298}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1510,time_per_message => 1510}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 1581,time_per_message => 1581}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2472,time_per_message => 2472}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2071,time_per_message => 2071}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 2630,time_per_message => 2630}}, {{mod_mam_pm_flushed,#{host_type => <<"test type">>}}, #{count => 1,time => 3247,time_per_message => 3247}}]
*** User 2024-04-23 06:55:39.912 ***🔗 Matching events: [{{mod_mam_pm_remove_archive,#{host_type => <<"test type">>}}, #{count => 1, jid => {jid,<<"alice_archive_is_instrumented_1972">>, <<"domain.example.com">>,<<>>}}}]
*** User 2024-04-23 06:55:39.912 ***🔗 bob_archive_is_instrumented_1972@domain.example.com/res1 out </stream:stream>
*** User 2024-04-23 06:55:39.913 ***🔗 bob_archive_is_instrumented_1972@domain.example.com/res1 in </stream:stream>
*** User 2024-04-23 06:55:39.913 ***🔗 alice_archive_is_instrumented_1972@domain.example.com/res1 out </stream:stream>
*** User 2024-04-23 06:55:39.913 ***🔗 alice_archive_is_instrumented_1972@domain.example.com/res1 in </stream:stream>
=== Ended at 2024-04-23 06:55:39 === successfully completed test case === === Returned value: ok