=== Test case: mam_SUITE:archive_chat_markers/1 (click for source code)
=== Config value:
[{props,[{mam_ns,<<"urn:xmpp:mam:1">>}]},
{watchdog,<0.3059.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@43a5deef6262.2022-01-27_15.25.11/big_tests.tests.mam_SUITE.logs/run.2022-01-27_15.29.00/mam_suite.archive_chat_markers.62851.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@43a5deef6262.2022-01-27_15.25.11/big_tests.tests.mam_SUITE.logs/run.2022-01-27_15.29.00/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@43a5deef6262.2022-01-27_15.25.11"
=== Started at 2022-01-27 15:29:43
*** User 2022-01-27 15:29:43.743 ***
alicE_unnamed_1259@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-27 15:29:43.743 ***
alicE_unnamed_1259@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='4375e2a220000978' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:29:43.744 ***
alicE_unnamed_1259@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-27 15:29:43.744 ***
alicE_unnamed_1259@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3VubmFtZWRfMTI1OQBtYXR5Z3J5c2E=</auth>
*** User 2022-01-27 15:29:43.745 ***
alicE_unnamed_1259@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:29:43.745 ***
alicE_unnamed_1259@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-27 15:29:43.745 ***
alicE_unnamed_1259@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a34bedd357f72209' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:29:43.745 ***
alicE_unnamed_1259@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-27 15:29:43.745 ***
alicE_unnamed_1259@localhost/res1 out
<iq type='set' id='0a5163091cfe4086be79bc6fe8ed2955'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 15:29:43.745 ***
alicE_unnamed_1259@localhost/res1 in
<iq id='0a5163091cfe4086be79bc6fe8ed2955' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>alicE_unnamed_1259@localhost/res1</jid>
</bind>
</iq>
*** User 2022-01-27 15:29:43.745 ***
alicE_unnamed_1259@localhost/res1 out
<iq type='set' id='d029470200ee7eea828d3e17e270feee'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:29:43.746 ***
alicE_unnamed_1259@localhost/res1 in
<iq type='result' id='d029470200ee7eea828d3e17e270feee'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:29:43.746 ***
alicE_unnamed_1259@localhost/res1 out
<presence/>
*** User 2022-01-27 15:29:43.748 ***
alicE_unnamed_1259@localhost/res1 in
<presence from='alicE_unnamed_1259@localhost/res1' to='alice_unnamed_1259@localhost/res1' xml:lang='en'/>
*** User 2022-01-27 15:29:43.749 ***
bOb_unnamed_1259@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-27 15:29:43.749 ***
bOb_unnamed_1259@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='045e8ed6907348d6' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:29:43.749 ***
bOb_unnamed_1259@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-27 15:29:43.749 ***
bOb_unnamed_1259@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl91bm5hbWVkXzEyNTkAbWFrcm9saWth</auth>
*** User 2022-01-27 15:29:43.750 ***
bOb_unnamed_1259@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:29:43.750 ***
bOb_unnamed_1259@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-27 15:29:43.750 ***
bOb_unnamed_1259@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='8bf96ee9609ae581' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:29:43.751 ***
bOb_unnamed_1259@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-27 15:29:43.751 ***
bOb_unnamed_1259@localhost/res1 out
<iq type='set' id='6b55bdc46ca13ce64dca03fa6d3d175b'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-01-27 15:29:43.751 ***
bOb_unnamed_1259@localhost/res1 in
<iq id='6b55bdc46ca13ce64dca03fa6d3d175b' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>bOb_unnamed_1259@localhost/res1</jid>
</bind>
</iq>
*** User 2022-01-27 15:29:43.751 ***
bOb_unnamed_1259@localhost/res1 out
<iq type='set' id='e14d440fb76e3c0dce8b289f1bc26fcb'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:29:43.751 ***
bOb_unnamed_1259@localhost/res1 in
<iq type='result' id='e14d440fb76e3c0dce8b289f1bc26fcb'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-01-27 15:29:43.751 ***
bOb_unnamed_1259@localhost/res1 out
<presence/>
*** User 2022-01-27 15:29:43.754 ***
bOb_unnamed_1259@localhost/res1 in
<presence from='bOb_unnamed_1259@localhost/res1' to='bob_unnamed_1259@localhost/res1' xml:lang='en'/>
*** User 2022-01-27 15:29:43.754 ***
alicE_unnamed_1259@localhost/res1 out
<message to='bOb_unnamed_1259@localhost/res1' type='chat' id='28193b293ea41c4aff1cc5dc36ee926f'>
<markable xmlns='urn:xmpp:chat-markers:0'/>
<body>Hello, Bob!</body>
</message>
*** User 2022-01-27 15:29:43.790 ***
bOb_unnamed_1259@localhost/res1 in
<message from='alicE_unnamed_1259@localhost/res1' to='bOb_unnamed_1259@localhost/res1' xml:lang='en' type='chat' id='28193b293ea41c4aff1cc5dc36ee926f'>
<markable xmlns='urn:xmpp:chat-markers:0'/>
<body>Hello, Bob!</body>
<stanza-id by='bOb_unnamed_1259@localhost' id='BLKHVJ8QOQO1' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 15:29:43.790 ***
bOb_unnamed_1259@localhost/res1 out
<message to='alicE_unnamed_1259@localhost/res1'>
<received xmlns='urn:xmpp:chat-markers:0' id='28193b293ea41c4aff1cc5dc36ee926f'/>
</message>
*** User 2022-01-27 15:29:43.790 ***
bOb_unnamed_1259@localhost/res1 out
<message to='alicE_unnamed_1259@localhost/res1'>
<displayed xmlns='urn:xmpp:chat-markers:0' id='28193b293ea41c4aff1cc5dc36ee926f'/>
</message>
*** User 2022-01-27 15:29:43.790 ***
bOb_unnamed_1259@localhost/res1 out
<message to='alicE_unnamed_1259@localhost/res1'>
<acknowledged xmlns='urn:xmpp:chat-markers:0' id='28193b293ea41c4aff1cc5dc36ee926f'/>
</message>
*** User 2022-01-27 15:29:43.793 ***
alicE_unnamed_1259@localhost/res1 in
<message from='bOb_unnamed_1259@localhost/res1' to='alicE_unnamed_1259@localhost/res1' xml:lang='en'>
<received xmlns='urn:xmpp:chat-markers:0' id='28193b293ea41c4aff1cc5dc36ee926f'/>
<stanza-id by='alicE_unnamed_1259@localhost' id='BLKHVJ93FV01' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 15:29:43.795 ***
alicE_unnamed_1259@localhost/res1 in
<message from='bOb_unnamed_1259@localhost/res1' to='alicE_unnamed_1259@localhost/res1' xml:lang='en'>
<displayed xmlns='urn:xmpp:chat-markers:0' id='28193b293ea41c4aff1cc5dc36ee926f'/>
<stanza-id by='alicE_unnamed_1259@localhost' id='BLKHVJ941M81' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-01-27 15:29:43.796 ***
alicE_unnamed_1259@localhost/res1 in
<message from='bOb_unnamed_1259@localhost/res1' to='alicE_unnamed_1259@localhost/res1' xml:lang='en'>
<acknowledged xmlns='urn:xmpp:chat-markers:0' id='28193b293ea41c4aff1cc5dc36ee926f'/>
<stanza-id by='alicE_unnamed_1259@localhost' id='BLKHVJ94HNG1' xmlns='urn:xmpp:sid:0'/>
</message>
Could not find element archive_wait in Config.
*** User 2022-01-27 15:29:43.810 ***
alicE_unnamed_1259@localhost/res1 out
<iq type='set' id='34c6c8f5390b7a40d1744f1bea3c087b'>
<query xmlns='urn:xmpp:mam:1' queryid='q1'>
<x xmlns='jabber:x:data'/>
</query>
</iq>
*** User 2022-01-27 15:29:43.811 ***
alicE_unnamed_1259@localhost/res1 in
<message from='alicE_unnamed_1259@localhost' to='alicE_unnamed_1259@localhost/res1' id='ec652ec5-eef3-46bc-a0e6-7b158e01c9a1'>
<result queryid='q1' xmlns='urn:xmpp:mam:1' id='BLKHVJ8QMQO1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T15:29:43Z' from='alice_unnamed_1259@localhost/res1'/>
<message from='alice_unnamed_1259@localhost/res1' xmlns='jabber:client' xml:lang='en' to='bOb_unnamed_1259@localhost/res1' type='chat' id='28193b293ea41c4aff1cc5dc36ee926f'>
<markable xmlns='urn:xmpp:chat-markers:0'/>
<body>Hello, Bob!</body>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 15:29:43.811 ***
alicE_unnamed_1259@localhost/res1 in
<message from='alicE_unnamed_1259@localhost' to='alicE_unnamed_1259@localhost/res1' id='40e243d3-e1f3-4514-a38b-3ef3086d9c91'>
<result queryid='q1' xmlns='urn:xmpp:mam:1' id='BLKHVJ93FV01'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T15:29:43Z' from='bob_unnamed_1259@localhost/res1'/>
<message from='bob_unnamed_1259@localhost/res1' xmlns='jabber:client' xml:lang='en' to='alicE_unnamed_1259@localhost/res1'>
<received xmlns='urn:xmpp:chat-markers:0' id='28193b293ea41c4aff1cc5dc36ee926f'/>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 15:29:43.812 ***
alicE_unnamed_1259@localhost/res1 in
<message from='alicE_unnamed_1259@localhost' to='alicE_unnamed_1259@localhost/res1' id='12348f1a-df0b-4eaf-b62b-4173cfb42c85'>
<result queryid='q1' xmlns='urn:xmpp:mam:1' id='BLKHVJ941M81'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T15:29:43Z' from='bob_unnamed_1259@localhost/res1'/>
<message from='bob_unnamed_1259@localhost/res1' xmlns='jabber:client' xml:lang='en' to='alicE_unnamed_1259@localhost/res1'>
<displayed xmlns='urn:xmpp:chat-markers:0' id='28193b293ea41c4aff1cc5dc36ee926f'/>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 15:29:43.812 ***
alicE_unnamed_1259@localhost/res1 in
<message from='alicE_unnamed_1259@localhost' to='alicE_unnamed_1259@localhost/res1' id='6244289f-8463-49f1-b268-8022d867b21f'>
<result queryid='q1' xmlns='urn:xmpp:mam:1' id='BLKHVJ94HNG1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-01-27T15:29:43Z' from='bob_unnamed_1259@localhost/res1'/>
<message from='bob_unnamed_1259@localhost/res1' xmlns='jabber:client' xml:lang='en' to='alicE_unnamed_1259@localhost/res1'>
<acknowledged xmlns='urn:xmpp:chat-markers:0' id='28193b293ea41c4aff1cc5dc36ee926f'/>
</message>
</forwarded>
</result>
</message>
*** User 2022-01-27 15:29:43.812 ***
alicE_unnamed_1259@localhost/res1 in
<iq from='alicE_unnamed_1259@localhost' to='alicE_unnamed_1259@localhost/res1' id='34c6c8f5390b7a40d1744f1bea3c087b' type='result'>
<fin xmlns='urn:xmpp:mam:1' complete='true'>
<set xmlns='http://jabber.org/protocol/rsm'>
<first index='0'>BLKHVJ8QMQO1</first>
<last>BLKHVJ94HNG1</last>
<count>4</count>
</set>
</fin>
</iq>
*** User 2022-01-27 15:29:43.812 ***
bOb_unnamed_1259@localhost/res1 out
</stream:stream>
*** User 2022-01-27 15:29:43.812 ***
bOb_unnamed_1259@localhost/res1 in
</stream:stream>
*** User 2022-01-27 15:29:43.812 ***
alicE_unnamed_1259@localhost/res1 out
</stream:stream>
*** User 2022-01-27 15:29:43.812 ***
alicE_unnamed_1259@localhost/res1 in
</stream:stream>
=== Ended at 2022-01-27 15:29:43
=== successfully completed test case
=== === Returned value: ok