=== Test case: mam_SUITE:archive_is_instrumented/1 (click for source code)

=== Config value:

    [{props,[{mam_ns,<<"urn:xmpp:mam:2">>}]},
     {watchdog,<0.46741.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,
                      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,
                      max_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,"mysql_redis"},
     {mim_data_dir,"/home/circleci/project/big_tests/tests/mam_SUITE_data"},
     {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@e9cd84e19dff.2024-04-23_06.47.01/big_tests.tests.mam_SUITE.logs/run.2024-04-23_06.54.11/mam_suite.archive_is_instrumented.83587.html"},
     {tc_group_properties,[{name,mam06},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@e9cd84e19dff.2024-04-23_06.47.01/big_tests.tests.mam_SUITE.logs/run.2024-04-23_06.54.11/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 => <<>>,affiliations => [],
                    subject => <<>>,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,anonymous => true,
                    max_users => 200,maygetmemberlist => [],logging => false,
                    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@e9cd84e19dff.2024-04-23_06.47.01"

=== Started at 2024-04-23 06:54:36


*** CT 2024-04-23 06:54:37.000 *** View log from node mongooseim@localhost when started🔗 mongooseim@localhost_2913.html

*** User 2024-04-23 06:54:37.059 ***🔗
alicE_archive_is_instrumented_1937@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:54:37.059 ***🔗
alicE_archive_is_instrumented_1937@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='e74942da67e23530' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2024-04-23 06:54:37.059 ***🔗
alicE_archive_is_instrumented_1937@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:54:37.059 ***🔗
alicE_archive_is_instrumented_1937@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX2FyY2hpdmVfaXNfaW5zdHJ1bWVudGVkXzE5MzcAbWF0eWdyeXNh</auth>



*** User 2024-04-23 06:54:37.060 ***🔗
alicE_archive_is_instrumented_1937@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2024-04-23 06:54:37.060 ***🔗
alicE_archive_is_instrumented_1937@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:54:37.061 ***🔗
alicE_archive_is_instrumented_1937@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='49b3bf504de37df5' from='domain.example.com' version='1.0' xml:lang='en' to='alice_archive_is_instrumented_1937@domain.example.com'>

*** User 2024-04-23 06:54:37.061 ***🔗
alicE_archive_is_instrumented_1937@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:54:37.062 ***🔗
alicE_archive_is_instrumented_1937@domain.example.com/res1 out
<iq type='set' id='0170775c900553f4842268a4cc8ac0a9'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2024-04-23 06:54:37.062 ***🔗
alicE_archive_is_instrumented_1937@domain.example.com/res1 in
<iq id='0170775c900553f4842268a4cc8ac0a9' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>alice_archive_is_instrumented_1937@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2024-04-23 06:54:37.062 ***🔗
alice_archive_is_instrumented_1937@domain.example.com/res1 out
<iq type='set' id='1e126d101a6189628591775e4fc8616e'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-23 06:54:37.063 ***🔗
alice_archive_is_instrumented_1937@domain.example.com/res1 in
<iq from='domain.example.com' to='alice_archive_is_instrumented_1937@domain.example.com/res1' id='1e126d101a6189628591775e4fc8616e' type='result'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-23 06:54:37.063 ***🔗
alice_archive_is_instrumented_1937@domain.example.com/res1 out
<presence/>



*** User 2024-04-23 06:54:37.066 ***🔗
alice_archive_is_instrumented_1937@domain.example.com/res1 in
<presence from='alice_archive_is_instrumented_1937@domain.example.com/res1' to='alice_archive_is_instrumented_1937@domain.example.com/res1'/>



*** User 2024-04-23 06:54:37.068 ***🔗
bOb_archive_is_instrumented_1937@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:54:37.068 ***🔗
bOb_archive_is_instrumented_1937@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='afe5090105247c6f' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2024-04-23 06:54:37.069 ***🔗
bOb_archive_is_instrumented_1937@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:54:37.069 ***🔗
bOb_archive_is_instrumented_1937@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9hcmNoaXZlX2lzX2luc3RydW1lbnRlZF8xOTM3AG1ha3JvbGlrYQ==</auth>



*** User 2024-04-23 06:54:37.070 ***🔗
bOb_archive_is_instrumented_1937@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2024-04-23 06:54:37.070 ***🔗
bOb_archive_is_instrumented_1937@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:54:37.070 ***🔗
bOb_archive_is_instrumented_1937@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='63dea6e86e947c2c' from='domain.example.com' version='1.0' xml:lang='en' to='bob_archive_is_instrumented_1937@domain.example.com'>

*** User 2024-04-23 06:54:37.071 ***🔗
bOb_archive_is_instrumented_1937@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:54:37.071 ***🔗
bOb_archive_is_instrumented_1937@domain.example.com/res1 out
<iq type='set' id='da4c27b6f53d472067edacb978d020a5'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2024-04-23 06:54:37.071 ***🔗
bOb_archive_is_instrumented_1937@domain.example.com/res1 in
<iq id='da4c27b6f53d472067edacb978d020a5' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>bob_archive_is_instrumented_1937@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2024-04-23 06:54:37.072 ***🔗
bob_archive_is_instrumented_1937@domain.example.com/res1 out
<iq type='set' id='81210790557f8542d4146798f4cde31a'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-23 06:54:37.073 ***🔗
bob_archive_is_instrumented_1937@domain.example.com/res1 in
<iq from='domain.example.com' to='bob_archive_is_instrumented_1937@domain.example.com/res1' id='81210790557f8542d4146798f4cde31a' type='result'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-23 06:54:37.073 ***🔗
bob_archive_is_instrumented_1937@domain.example.com/res1 out
<presence/>



*** User 2024-04-23 06:54:37.075 ***🔗
bob_archive_is_instrumented_1937@domain.example.com/res1 in
<presence from='bob_archive_is_instrumented_1937@domain.example.com/res1' to='bob_archive_is_instrumented_1937@domain.example.com/res1'/>



*** User 2024-04-23 06:54:37.075 ***🔗
alice_archive_is_instrumented_1937@domain.example.com/res1 out
<message type='chat' to='bob_archive_is_instrumented_1937@domain.example.com/res1'>
	<body>OH, HAI!</body>
</message>



*** User 2024-04-23 06:54:37.089 ***🔗
bob_archive_is_instrumented_1937@domain.example.com/res1 in
<message from='alice_archive_is_instrumented_1937@domain.example.com/res1' to='bob_archive_is_instrumented_1937@domain.example.com/res1' type='chat'>
	<body>OH, HAI!</body>
	<stanza-id by='bob_archive_is_instrumented_1937@domain.example.com' id='C5LU0RU8SUO1' xmlns='urn:xmpp:sid:0'/>
</message>



*** User 2024-04-23 06:54:37.156 ***🔗
Matching events: [{{mod_mam_pm_archive_message,
                    #{host_type => <<"test type">>}},
                   #{count => 1,time => 9,
                     params =>
                      #{packet =>
                         {xmlel,<<"message">>,
                          [{<<"type">>,<<"chat">>},
                           {<<"to">>,
                            <<"bob_archive_is_instrumented_1937@domain.example.com/res1">>}],
                          [{xmlel,<<"body">>,[],[{xmlcdata,<<"OH, HAI!">>}]}]},
                        direction => outgoing,archive_id => 809,
                        origin_id => none,message_id => 438746950931479041,
                        source_jid =>
                         {jid,<<"alice_archive_is_instrumented_1937">>,
                          <<"domain.example.com">>,<<"res1">>},
                        remote_jid =>
                         {jid,<<"bob_archive_is_instrumented_1937">>,
                          <<"domain.example.com">>,<<"res1">>},
                        local_jid =>
                         {jid,<<"alice_archive_is_instrumented_1937">>,
                          <<"domain.example.com">>,<<"res1">>},
                        is_groupchat => false}}}]

*** User 2024-04-23 06:54:37.169 ***🔗
waiting for archive_size is done in 0 miliseconds

*** User 2024-04-23 06:54:37.170 ***🔗
Matching events: [{{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 851,time_per_message => 851}},
                  {{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 => 1092,time_per_message => 1092}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 1897,time_per_message => 949}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1170,time_per_message => 1170}},
                  {{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 => 629,time_per_message => 629}},
                  {{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 => 872,time_per_message => 872}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 2568,time_per_message => 856}},
                  {{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 => 1108,time_per_message => 1108}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 1853,time_per_message => 927}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1260,time_per_message => 1260}},
                  {{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 => 935,time_per_message => 935}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2113,time_per_message => 1057}},
                  {{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 => 4513,time_per_message => 4513}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 5564,time_per_message => 5564}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 6175,time_per_message => 3088}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 788,time_per_message => 788}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1016,time_per_message => 1016}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2802,time_per_message => 1401}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1269,time_per_message => 1269}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2193,time_per_message => 2193}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 3757,time_per_message => 1252}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2662,time_per_message => 1331}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2316,time_per_message => 2316}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 3844,time_per_message => 1922}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1420,time_per_message => 1420}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2005,time_per_message => 2005}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1458,time_per_message => 1458}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 4043,time_per_message => 2022}},
                  {{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 => 2,time => 3407,time_per_message => 1704}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 4981,time_per_message => 1660}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2971,time_per_message => 1486}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 5687,time_per_message => 1896}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2541,time_per_message => 2541}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 5631,time_per_message => 2816}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 4314,time_per_message => 2157}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 4993,time_per_message => 2497}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 4889,time_per_message => 2445}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 5944,time_per_message => 2972}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 4449,time_per_message => 4449}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3802,time_per_message => 3802}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2296,time_per_message => 2296}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 6526,time_per_message => 3263}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 5366,time_per_message => 2683}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2334,time_per_message => 2334}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 4417,time_per_message => 4417}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 4900,time_per_message => 2450}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 9360,time_per_message => 3120}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 10890,time_per_message => 3630}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3263,time_per_message => 3263}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3987,time_per_message => 3987}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 4,time => 14232,time_per_message => 3558}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 4,time => 11452,time_per_message => 2863}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 4879,time_per_message => 2440}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3565,time_per_message => 3565}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3968,time_per_message => 3968}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 60206,time_per_message => 60206}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3189,time_per_message => 3189}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3284,time_per_message => 3284}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 63928,time_per_message => 21309}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 4,time => 71915,time_per_message => 17979}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3999,time_per_message => 3999}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 5,time => 73872,time_per_message => 14774}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2551,time_per_message => 2551}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 6,time => 73500,time_per_message => 12250}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3407,time_per_message => 3407}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 5,time => 75592,time_per_message => 15118}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 7016,time_per_message => 3508}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1607,time_per_message => 1607}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2018,time_per_message => 2018}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 14772,time_per_message => 4924}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2900,time_per_message => 2900}},
                  {{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 => 6,time => 18982,time_per_message => 3164}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1528,time_per_message => 1528}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 6,time => 18250,time_per_message => 3042}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1617,time_per_message => 1617}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1384,time_per_message => 1384}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 6,time => 14246,time_per_message => 2374}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1119,time_per_message => 1119}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 6,time => 9643,time_per_message => 1607}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 7,time => 15942,time_per_message => 2277}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1471,time_per_message => 1471}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1291,time_per_message => 1291}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 6,time => 7845,time_per_message => 1308}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 7,time => 9448,time_per_message => 1350}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2800,time_per_message => 2800}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1668,time_per_message => 1668}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 7,time => 7935,time_per_message => 1134}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2386,time_per_message => 2386}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 58437,time_per_message => 58437}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 60421,time_per_message => 30211}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 60908,time_per_message => 30454}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 3660,time_per_message => 1830}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 6,time => 67368,time_per_message => 11228}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2356,time_per_message => 1178}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1201,time_per_message => 1201}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 10,time => 70578,time_per_message => 7058}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1194,time_per_message => 1194}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2054,time_per_message => 1027}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 4,time => 3768,time_per_message => 942}},
                  {{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 => 827,time_per_message => 827}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1261,time_per_message => 1261}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 632,time_per_message => 632}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 679,time_per_message => 679}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 734,time_per_message => 734}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 2566,time_per_message => 855}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 972,time_per_message => 972}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 662,time_per_message => 662}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 725,time_per_message => 725}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 857,time_per_message => 857}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 723,time_per_message => 723}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 703,time_per_message => 703}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 711,time_per_message => 711}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 577,time_per_message => 577}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 582,time_per_message => 582}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 744,time_per_message => 744}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 566,time_per_message => 566}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 752,time_per_message => 752}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 639,time_per_message => 639}},
                  {{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 => 558,time_per_message => 558}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 835,time_per_message => 835}},
                  {{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 => 903,time_per_message => 903}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1010,time_per_message => 1010}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 731,time_per_message => 731}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 708,time_per_message => 708}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1610,time_per_message => 1610}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 709,time_per_message => 709}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1008,time_per_message => 1008}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 659,time_per_message => 659}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1175,time_per_message => 1175}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1122,time_per_message => 1122}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2015,time_per_message => 1008}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2412,time_per_message => 1206}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 702,time_per_message => 702}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 907,time_per_message => 907}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1140,time_per_message => 1140}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 1947,time_per_message => 974}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1842,time_per_message => 1842}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 2738,time_per_message => 913}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 838,time_per_message => 838}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1231,time_per_message => 1231}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1366,time_per_message => 1366}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1628,time_per_message => 1628}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2128,time_per_message => 2128}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 978,time_per_message => 978}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1302,time_per_message => 1302}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1856,time_per_message => 1856}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 991,time_per_message => 991}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 4104,time_per_message => 1368}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 3,time => 3419,time_per_message => 1140}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2059,time_per_message => 2059}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 898,time_per_message => 898}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 687,time_per_message => 687}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1162,time_per_message => 1162}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2648,time_per_message => 1324}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2227,time_per_message => 1114}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1350,time_per_message => 1350}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2456,time_per_message => 2456}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3098,time_per_message => 3098}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1614,time_per_message => 1614}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 4,time => 5612,time_per_message => 1403}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2425,time_per_message => 2425}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1503,time_per_message => 1503}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2366,time_per_message => 1183}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 8435,time_per_message => 4218}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1234,time_per_message => 1234}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1466,time_per_message => 1466}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2412,time_per_message => 2412}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 2709,time_per_message => 1355}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 715,time_per_message => 715}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 4,time => 6736,time_per_message => 1684}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2474,time_per_message => 2474}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 1722,time_per_message => 1722}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2758,time_per_message => 2758}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3209,time_per_message => 3209}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 3496,time_per_message => 3496}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 53930,time_per_message => 53930}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2231,time_per_message => 2231}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 2,time => 56397,time_per_message => 28199}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 52342,time_per_message => 52342}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 5101,time_per_message => 5101}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 5096,time_per_message => 5096}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 2529,time_per_message => 2529}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 7438,time_per_message => 7438}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 4,time => 66612,time_per_message => 16653}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 1,time => 5717,time_per_message => 5717}},
                  {{mod_mam_pm_flushed,#{host_type => <<"test type">>}},
                   #{count => 4,time => 68946,time_per_message => 17237}}]

*** User 2024-04-23 06:54:37.186 ***🔗
Matching events: [{{mod_mam_pm_remove_archive,#{host_type => <<"test type">>}},
                   #{count => 1,
                     jid =>
                         {jid,<<"alice_archive_is_instrumented_1937">>,
                              <<"domain.example.com">>,<<>>}}}]

*** User 2024-04-23 06:54:37.186 ***🔗
bob_archive_is_instrumented_1937@domain.example.com/res1 out
</stream:stream>

*** User 2024-04-23 06:54:37.187 ***🔗
bob_archive_is_instrumented_1937@domain.example.com/res1 in
</stream:stream>

*** User 2024-04-23 06:54:37.187 ***🔗
alice_archive_is_instrumented_1937@domain.example.com/res1 out
</stream:stream>

*** User 2024-04-23 06:54:37.187 ***🔗
alice_archive_is_instrumented_1937@domain.example.com/res1 in
</stream:stream>
*** CT 2024-04-23 06:54:37.195 *** View log from node mongooseim@localhost when finished🔗 mongooseim@localhost_2913.html



=== Ended at 2024-04-23 06:54:37
=== successfully completed test case
=== === Returned value: ok