=== Test case: mam_SUITE:archive_chat_markers/1 (click for source code)
=== Config value:
[{props,[{mam_ns,<<"urn:xmpp:mam:1">>}]},
{watchdog,<0.2573.1>},
{basic_group,chat_markers},
{configuration,rdbms_async_cache},
{wait_for_parallel_writer,[pm]},
{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@ebe8a8f9fc53.2022-01-25_16.21.59/big_tests.tests.mam_SUITE.logs/run.2022-01-25_16.25.52/mam_suite.archive_chat_markers.43780.html"},
{tc_group_properties,[{name,mam04},parallel]},
{tc_group_path,[[{name,rdbms_async_cache_chat_markers},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@ebe8a8f9fc53.2022-01-25_16.21.59/big_tests.tests.mam_SUITE.logs/run.2022-01-25_16.25.52/log_private/"},
{config_backup,#{[shaper,fast] => {ok,#{max_rate => 50000}},
[shaper,mam_shaper] => {ok,#{max_rate => 1}},
[shaper,normal] => {ok,#{max_rate => 1000}},
[{access,<<"localhost">>},max_user_sessions] =>
{ok,[#{acl => all,value => 10}]}}},
{{saved_modules,mongooseim@localhost,<<"localhost">>},
#{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_chat_markers,true},{archive_groupchats,false}],
mod_mam_cache_user => [{pm,true}],
mod_mam_rdbms_arch => [{no_writer,true}],
mod_mam_rdbms_arch_async => [{pm,[{flush_interval,1}]}],
mod_mam_rdbms_prefs => [{pm,true}],
mod_mam_rdbms_user => [{pm,true}],
mod_muc =>
[{host,{prefix,<<"muc.">>}},
{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,<<"localhost">>},
{password,<<"matygrysa">>}]},
{bob,[{username,<<"bOb">>},
{server,<<"localhost">>},
{password,<<"makrolika">>}]},
{kate,[{username,<<"kate">>},
{server,<<"localhost">>},
{password,<<"makrowe;p">>}]},
{carol,[{username,<<"carol">>},
{server,<<"localhost">>},
{password,<<"jinglebells">>},
{transport,escalus_bosh},
{path,<<"/http-bind">>},
{port,5280}]}]}]
=== Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@ebe8a8f9fc53.2022-01-25_16.21.59"
=== Started at 2022-01-25 16:26:46
*** User 2022-01-25 16:26:46.367 ***
alicE_unnamed_1257@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-25 16:26:46.368 ***
alicE_unnamed_1257@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='484282c4c06c6b02' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:26:46.368 ***
alicE_unnamed_1257@localhost/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-25 16:26:46.368 ***
alicE_unnamed_1257@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3VubmFtZWRfMTI1NwBtYXR5Z3J5c2E=</auth>
*** User 2022-01-25 16:26:46.370 ***
alicE_unnamed_1257@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:26:46.370 ***
alicE_unnamed_1257@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-25 16:26:46.370 ***
alicE_unnamed_1257@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a3d9dc2aaf52a092' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:26:46.370 ***
alicE_unnamed_1257@localhost/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-25 16:26:46.370 ***
alicE_unnamed_1257@localhost/res1 out
<iq type='set' id='5b3005510912332f8f9a8afd0d382b98'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-25 16:26:46.371 ***
alicE_unnamed_1257@localhost/res1 in
<iq id='5b3005510912332f8f9a8afd0d382b98' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>alicE_unnamed_1257@localhost/res1</jid>
</bind>
</iq>
*** User 2022-01-25 16:26:46.371 ***
alicE_unnamed_1257@localhost/res1 out
<iq type='set' id='b6bc67528cfbb8f1247a1d125873fdda'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-25 16:26:46.371 ***
alicE_unnamed_1257@localhost/res1 in
<iq type='result' id='b6bc67528cfbb8f1247a1d125873fdda'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-25 16:26:46.371 ***
alicE_unnamed_1257@localhost/res1 out
<presence/>
*** User 2022-01-25 16:26:46.374 ***
alicE_unnamed_1257@localhost/res1 in
<presence from='alicE_unnamed_1257@localhost/res1' to='alice_unnamed_1257@localhost/res1' xml:lang='en'/>
*** User 2022-01-25 16:26:46.375 ***
bOb_unnamed_1257@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-25 16:26:46.375 ***
bOb_unnamed_1257@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d43b716825f46fa4' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:26:46.375 ***
bOb_unnamed_1257@localhost/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-25 16:26:46.375 ***
bOb_unnamed_1257@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl91bm5hbWVkXzEyNTcAbWFrcm9saWth</auth>
*** User 2022-01-25 16:26:46.376 ***
bOb_unnamed_1257@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:26:46.377 ***
bOb_unnamed_1257@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-01-25 16:26:46.377 ***
bOb_unnamed_1257@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='84c4766e713c30a3' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:26:46.377 ***
bOb_unnamed_1257@localhost/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-25 16:26:46.377 ***
bOb_unnamed_1257@localhost/res1 out
<iq type='set' id='ba7d75838820e476a24316f44d28fae1'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-25 16:26:46.377 ***
bOb_unnamed_1257@localhost/res1 in
<iq id='ba7d75838820e476a24316f44d28fae1' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>bOb_unnamed_1257@localhost/res1</jid>
</bind>
</iq>
*** User 2022-01-25 16:26:46.377 ***
bOb_unnamed_1257@localhost/res1 out
<iq type='set' id='12a719c566714fc652c30e8afa66b84b'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-25 16:26:46.378 ***
bOb_unnamed_1257@localhost/res1 in
<iq type='result' id='12a719c566714fc652c30e8afa66b84b'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-25 16:26:46.378 ***
bOb_unnamed_1257@localhost/res1 out
<presence/>
*** User 2022-01-25 16:26:46.380 ***
bOb_unnamed_1257@localhost/res1 in
<presence from='bOb_unnamed_1257@localhost/res1' to='bob_unnamed_1257@localhost/res1' xml:lang='en'/>
*** User 2022-01-25 16:26:46.380 ***
alicE_unnamed_1257@localhost/res1 out
<message to='bOb_unnamed_1257@localhost/res1' type='chat' id='459044df68885d6ba3a3eaa440fdf347'>
<markable xmlns='urn:xmpp:chat-markers:0'/>
<body>Hello, Bob!</body>
</message>
*** User 2022-01-25 16:26:46.410 ***
bOb_unnamed_1257@localhost/res1 in
<message from='alicE_unnamed_1257@localhost/res1' to='bOb_unnamed_1257@localhost/res1' xml:lang='en' type='chat' id='459044df68885d6ba3a3eaa440fdf347'>
<markable xmlns='urn:xmpp:chat-markers:0'/>
<body>Hello, Bob!</body>
<stanza-id by='bOb_unnamed_1257@localhost' id='BLJAHKI0TCG1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-25 16:26:46.410 ***
bOb_unnamed_1257@localhost/res1 out
<message to='alicE_unnamed_1257@localhost/res1'>
<received xmlns='urn:xmpp:chat-markers:0' id='459044df68885d6ba3a3eaa440fdf347'/>
</message>
*** User 2022-01-25 16:26:46.410 ***
bOb_unnamed_1257@localhost/res1 out
<message to='alicE_unnamed_1257@localhost/res1'>
<displayed xmlns='urn:xmpp:chat-markers:0' id='459044df68885d6ba3a3eaa440fdf347'/>
</message>
*** User 2022-01-25 16:26:46.410 ***
bOb_unnamed_1257@localhost/res1 out
<message to='alicE_unnamed_1257@localhost/res1'>
<acknowledged xmlns='urn:xmpp:chat-markers:0' id='459044df68885d6ba3a3eaa440fdf347'/>
</message>
*** User 2022-01-25 16:26:46.412 ***
alicE_unnamed_1257@localhost/res1 in
<message from='bOb_unnamed_1257@localhost/res1' to='alicE_unnamed_1257@localhost/res1' xml:lang='en'>
<received xmlns='urn:xmpp:chat-markers:0' id='459044df68885d6ba3a3eaa440fdf347'/>
<stanza-id by='alicE_unnamed_1257@localhost' id='BLJAHKI82BG1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-25 16:26:46.417 ***
alicE_unnamed_1257@localhost/res1 in
<message from='bOb_unnamed_1257@localhost/res1' to='alicE_unnamed_1257@localhost/res1' xml:lang='en'>
<displayed xmlns='urn:xmpp:chat-markers:0' id='459044df68885d6ba3a3eaa440fdf347'/>
<stanza-id by='alicE_unnamed_1257@localhost' id='BLJAHKI8H101' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-25 16:26:46.419 ***
alicE_unnamed_1257@localhost/res1 in
<message from='bOb_unnamed_1257@localhost/res1' to='alicE_unnamed_1257@localhost/res1' xml:lang='en'>
<acknowledged xmlns='urn:xmpp:chat-markers:0' id='459044df68885d6ba3a3eaa440fdf347'/>
<stanza-id by='alicE_unnamed_1257@localhost' id='BLJAHKI9JJG1' xmlns='urn:xmpp:sid:0'/>
</message>
Could not find element archive_wait in Config.
*** User 2022-01-25 16:26:46.433 ***
alicE_unnamed_1257@localhost/res1 out
<iq type='set' id='4f0351b84a9ed75161c720539814ca4b'>
<query xmlns='urn:xmpp:mam:1' queryid='q1'>
<x xmlns='jabber:x:data'/>
</query>
</iq>
*** User 2022-01-25 16:26:46.435 ***
alicE_unnamed_1257@localhost/res1 in
<message from='alicE_unnamed_1257@localhost' to='alicE_unnamed_1257@localhost/res1' id='dd263c25-eefb-4cbb-8e13-e5b90247c37d'>
<result queryid='q1' xmlns='urn:xmpp:mam:1' id='BLJAHKI0PD81'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:26:46Z' from='alice_unnamed_1257@localhost/res1'/>
<message from='alice_unnamed_1257@localhost/res1' xmlns='jabber:client' xml:lang='en' to='bOb_unnamed_1257@localhost/res1' type='chat' id='459044df68885d6ba3a3eaa440fdf347'>
<markable xmlns='urn:xmpp:chat-markers:0'/>
<body>Hello, Bob!</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-25 16:26:46.435 ***
alicE_unnamed_1257@localhost/res1 in
<message from='alicE_unnamed_1257@localhost' to='alicE_unnamed_1257@localhost/res1' id='233cdccd-4dce-4858-b81f-d1d21b7d525a'>
<result queryid='q1' xmlns='urn:xmpp:mam:1' id='BLJAHKI82BG1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:26:46Z' from='bob_unnamed_1257@localhost/res1'/>
<message from='bob_unnamed_1257@localhost/res1' xmlns='jabber:client' xml:lang='en' to='alicE_unnamed_1257@localhost/res1'>
<received xmlns='urn:xmpp:chat-markers:0' id='459044df68885d6ba3a3eaa440fdf347'/>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-25 16:26:46.436 ***
alicE_unnamed_1257@localhost/res1 in
<message from='alicE_unnamed_1257@localhost' to='alicE_unnamed_1257@localhost/res1' id='cca529bc-329b-4ef9-b8d5-acb720145187'>
<result queryid='q1' xmlns='urn:xmpp:mam:1' id='BLJAHKI8H101'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:26:46Z' from='bob_unnamed_1257@localhost/res1'/>
<message from='bob_unnamed_1257@localhost/res1' xmlns='jabber:client' xml:lang='en' to='alicE_unnamed_1257@localhost/res1'>
<displayed xmlns='urn:xmpp:chat-markers:0' id='459044df68885d6ba3a3eaa440fdf347'/>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-25 16:26:46.436 ***
alicE_unnamed_1257@localhost/res1 in
<message from='alicE_unnamed_1257@localhost' to='alicE_unnamed_1257@localhost/res1' id='a97978c1-149f-445f-8376-0391eb41259d'>
<result queryid='q1' xmlns='urn:xmpp:mam:1' id='BLJAHKI9JJG1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:26:46Z' from='bob_unnamed_1257@localhost/res1'/>
<message from='bob_unnamed_1257@localhost/res1' xmlns='jabber:client' xml:lang='en' to='alicE_unnamed_1257@localhost/res1'>
<acknowledged xmlns='urn:xmpp:chat-markers:0' id='459044df68885d6ba3a3eaa440fdf347'/>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-25 16:26:46.436 ***
alicE_unnamed_1257@localhost/res1 in
<iq from='alicE_unnamed_1257@localhost' to='alicE_unnamed_1257@localhost/res1' id='4f0351b84a9ed75161c720539814ca4b' type='result'>
<fin xmlns='urn:xmpp:mam:1' complete='true'>
<set xmlns='http://jabber.org/protocol/rsm'>
<first index='0'>BLJAHKI0PD81</first>
<last>BLJAHKI9JJG1</last>
<count>4</count>
</set>
</fin>
</iq>
*** User 2022-01-25 16:26:46.436 ***
bOb_unnamed_1257@localhost/res1 out
</stream:stream>
*** User 2022-01-25 16:26:46.436 ***
bOb_unnamed_1257@localhost/res1 in
</stream:stream>
*** User 2022-01-25 16:26:46.436 ***
alicE_unnamed_1257@localhost/res1 out
</stream:stream>
*** User 2022-01-25 16:26:46.436 ***
alicE_unnamed_1257@localhost/res1 in
</stream:stream>
=== Ended at 2022-01-25 16:26:46
=== successfully completed test case
=== === Returned value: ok