=== Test case: mam_SUITE:retract_message/1 (click for source code)
=== Config value:
[{props,[{mam_ns,<<"urn:xmpp:mam:2">>}]},
{watchdog,<0.4591.1>},
{basic_group,disabled_retraction},
{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@88d84ff17c71.2022-03-04_11.16.52/big_tests.tests.mam_SUITE.logs/run.2022-03-04_11.20.29/mam_suite.retract_message.61315.html"},
{tc_group_properties,[{name,mam06},parallel]},
{tc_group_path,[[{name,rdbms_async_cache_disabled_retraction}]]},
{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@88d84ff17c71.2022-03-04_11.16.52/big_tests.tests.mam_SUITE.logs/run.2022-03-04_11.20.29/log_private/"},
{config_backup,#{[shaper,fast] => {ok,#{max_rate => 50000}},
[shaper,mam_shaper] => {ok,#{max_rate => 1}},
[shaper,normal] => {ok,#{max_rate => 1000}},
[{access,<<"test type">>},max_user_sessions] =>
{ok,[#{acl => all,value => 10}]}}},
{{saved_modules,mongooseim@localhost,<<"test type">>},
#{mod_adhoc => [],mod_amp => [],mod_bosh => [],
mod_cache_users => [{number_of_segments,5},{time_to_live,2}],
mod_carboncopy => [],mod_commands => [],
mod_disco => [{users_can_see_hidden_services,false}],
mod_mam => [{message_retraction,false},{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,<<"groupchats.">>}},
{backend,rdbms},
{hibernate_timeout,2000},
{hibernated_room_check_interval,1000},
{hibernated_room_timeout,2000},
{access,muc},
{access_create,muc_create}],
mod_muc_commands => [],mod_muc_light_commands => [],
mod_muc_log => [{outdir,"/tmp/muclogs"},{access_log,muc}],
mod_register =>
[{access,register},
{ip_access,[{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]},
{welcome_message,{[],[]}}],
mod_roster => [{backend,rdbms}],
mod_sic => [],mod_stream_management => [],
mod_vcard => [{backend,rdbms},{host,{prefix,<<"vjud.">>}}]}},
{escalus_users,[{alice,[{username,<<"alicE">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"matygrysa">>}]},
{bob,[{username,<<"bOb">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"makrolika">>}]},
{kate,[{username,<<"kate">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"makrowe;p">>}]},
{carol,[{username,<<"carol">>},
{server,<<"domain.example.com">>},
{host,<<"localhost">>},
{password,<<"jinglebells">>},
{transport,escalus_bosh},
{path,<<"/http-bind">>},
{port,5280}]}]}]
=== Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@88d84ff17c71.2022-03-04_11.16.52"
=== Started at 2022-03-04 11:21:11
*** User 2022-03-04 11:21:11.498 ***
alicE_retract_message_1293@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-03-04 11:21:11.498 ***
alicE_retract_message_1293@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='59ee1c456aa2bf7c' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-03-04 11:21:11.499 ***
alicE_retract_message_1293@domain.example.com/res1 in
<stream:features>
<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
<mechanism>SCRAM-SHA-256</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-03-04 11:21:11.499 ***
alicE_retract_message_1293@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3JldHJhY3RfbWVzc2FnZV8xMjkzAG1hdHlncnlzYQ==</auth>
*** User 2022-03-04 11:21:11.499 ***
alicE_retract_message_1293@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-03-04 11:21:11.500 ***
alicE_retract_message_1293@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-03-04 11:21:11.500 ***
alicE_retract_message_1293@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d5d15238541f00e3' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-03-04 11:21:11.500 ***
alicE_retract_message_1293@domain.example.com/res1 in
<stream:features>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-03-04 11:21:11.500 ***
alicE_retract_message_1293@domain.example.com/res1 out
<iq type='set' id='2bae6c91845f7b5eff2f9bea3f47ecd7'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-03-04 11:21:11.500 ***
alicE_retract_message_1293@domain.example.com/res1 in
<iq id='2bae6c91845f7b5eff2f9bea3f47ecd7' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>alicE_retract_message_1293@domain.example.com/res1</jid>
</bind>
</iq>
*** User 2022-03-04 11:21:11.500 ***
alicE_retract_message_1293@domain.example.com/res1 out
<iq type='set' id='03cde862622427e27aad0ecd41da59e1'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-03-04 11:21:11.501 ***
alicE_retract_message_1293@domain.example.com/res1 in
<iq type='result' id='03cde862622427e27aad0ecd41da59e1'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-03-04 11:21:11.501 ***
alicE_retract_message_1293@domain.example.com/res1 out
<presence/>
*** User 2022-03-04 11:21:11.503 ***
alicE_retract_message_1293@domain.example.com/res1 in
<presence from='alicE_retract_message_1293@domain.example.com/res1' to='alice_retract_message_1293@domain.example.com/res1' xml:lang='en'/>
*** User 2022-03-04 11:21:11.504 ***
bOb_retract_message_1293@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-03-04 11:21:11.504 ***
bOb_retract_message_1293@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='629ad4f19bb958de' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-03-04 11:21:11.504 ***
bOb_retract_message_1293@domain.example.com/res1 in
<stream:features>
<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
<mechanism>SCRAM-SHA-256</mechanism>
<mechanism>PLAIN</mechanism>
</mechanisms>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-03-04 11:21:11.505 ***
bOb_retract_message_1293@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9yZXRyYWN0X21lc3NhZ2VfMTI5MwBtYWtyb2xpa2E=</auth>
*** User 2022-03-04 11:21:11.506 ***
bOb_retract_message_1293@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-03-04 11:21:11.506 ***
bOb_retract_message_1293@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-03-04 11:21:11.506 ***
bOb_retract_message_1293@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='17e984d82b267413' from='domain.example.com' version='1.0' xml:lang='en'>
*** User 2022-03-04 11:21:11.506 ***
bOb_retract_message_1293@domain.example.com/res1 in
<stream:features>
<compression xmlns='http://jabber.org/features/compress'>
<method>zlib</method>
</compression>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
<register xmlns='http://jabber.org/features/iq-register'/>
<amp xmlns='http://jabber.org/feature/amp'/>
<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>
*** User 2022-03-04 11:21:11.506 ***
bOb_retract_message_1293@domain.example.com/res1 out
<iq type='set' id='ece3e6b2c5c946106f696f3c216f68e9'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2022-03-04 11:21:11.506 ***
bOb_retract_message_1293@domain.example.com/res1 in
<iq id='ece3e6b2c5c946106f696f3c216f68e9' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>bOb_retract_message_1293@domain.example.com/res1</jid>
</bind>
</iq>
*** User 2022-03-04 11:21:11.507 ***
bOb_retract_message_1293@domain.example.com/res1 out
<iq type='set' id='df7d9acea8fb1ab1a30043b54c312ea6'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-03-04 11:21:11.507 ***
bOb_retract_message_1293@domain.example.com/res1 in
<iq type='result' id='df7d9acea8fb1ab1a30043b54c312ea6'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2022-03-04 11:21:11.507 ***
bOb_retract_message_1293@domain.example.com/res1 out
<presence/>
*** User 2022-03-04 11:21:11.509 ***
bOb_retract_message_1293@domain.example.com/res1 in
<presence from='bOb_retract_message_1293@domain.example.com/res1' to='bob_retract_message_1293@domain.example.com/res1' xml:lang='en'/>
*** User 2022-03-04 11:21:11.509 ***
alicE_retract_message_1293@domain.example.com/res1 out
<message to='bOb_retract_message_1293@domain.example.com/res1' type='chat'>
<body>OH, HAI!</body>
<origin-id xmlns='urn:xmpp:sid:0' id='orig-id-1'/>
</message>
*** System report during mam06 in mam_SUITE 2022-03-04 11:21:11.513 ***
=WARNING REPORT==== 4-Mar-2022::11:21:11.513075 ===
host: <<"test type">>
reason: {error,#{odbc_params =>
[{{sql_wlongvarchar,18},
[<<100,0,111,0,109,0,97,0,105,0,110,0,46,0,101,0,
120,0,97,0,109,0,112,0,108,0,101,0,46,0,99,0,
111,0,109,0>>]},
{{sql_wlongvarchar,26},
[<<97,0,108,0,105,0,99,0,101,0,95,0,114,0,101,0,
116,0,114,0,97,0,99,0,116,0,95,0,109,0,101,0,
115,0,115,0,97,0,103,0,101,0,95,0,49,0,50,0,
57,0,51,0>>]}],
odbc_query =>
<<"INSERT INTO mam_server_user (server, user_name) VALUES (?, ?)">>,
reason =>
"[FreeTDS][SQL Server]Violation of UNIQUE KEY constraint 'mam_server_user$uc_mam_server_user_name'. Cannot insert duplicate key in object 'dbo.mam_server_user'. The duplicate key value is (domain.example.com, alice_retract_message_1293).[FreeTDS][SQL Server]The statement has been terminated. SQLSTATE IS: 01000"}}
server: <<"domain.example.com">>
user: <<"alice_retract_message_1293">>
what: create_user_archive_failed
*** User 2022-03-04 11:21:11.617 ***
alicE_retract_message_1293@domain.example.com/res1 out
<iq type='set' id='e707e73366a49fb915e3d044028279c2'>
<query xmlns='urn:xmpp:mam:2' queryid='q1'>
<x xmlns='jabber:x:data'/>
</query>
</iq>
*** User 2022-03-04 11:21:11.618 ***
alicE_retract_message_1293@domain.example.com/res1 in
<message from='alicE_retract_message_1293@domain.example.com' to='alicE_retract_message_1293@domain.example.com/res1' id='061c1625-d11f-4943-be14-e767ec95eea7'>
<result queryid='q1' xmlns='urn:xmpp:mam:2' id='BMB2MP25R2O1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:21:11Z' from='alice_retract_message_1293@domain.example.com/res1'/>
<message from='alice_retract_message_1293@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_retract_message_1293@domain.example.com/res1' type='chat'>
<body>OH, HAI!</body>
<origin-id xmlns='urn:xmpp:sid:0' id='orig-id-1'/>
</message>
</forwarded>
</result>
</message>
Could not find element retract_on in Config.
*** User 2022-03-04 11:21:11.618 ***
alicE_retract_message_1293@domain.example.com/res1 in
<iq from='alicE_retract_message_1293@domain.example.com' to='alicE_retract_message_1293@domain.example.com/res1' id='e707e73366a49fb915e3d044028279c2' type='result'>
<fin xmlns='urn:xmpp:mam:2' complete='true'>
<set xmlns='http://jabber.org/protocol/rsm'>
<first index='0'>BMB2MP25R2O1</first>
<last>BMB2MP25R2O1</last>
<count>1</count>
</set>
</fin>
</iq>
*** User 2022-03-04 11:21:11.619 ***
bOb_retract_message_1293@domain.example.com/res1 in
<message from='alicE_retract_message_1293@domain.example.com/res1' to='bOb_retract_message_1293@domain.example.com/res1' xml:lang='en' type='chat'>
<body>OH, HAI!</body>
<origin-id xmlns='urn:xmpp:sid:0' id='orig-id-1'/>
<stanza-id by='bOb_retract_message_1293@domain.example.com' id='BMB2MP25R301' xmlns='urn:xmpp:sid:0'/>
</message>
*** User 2022-03-04 11:21:11.619 ***
alicE_retract_message_1293@domain.example.com/res1 out
<message type='chat' to='bOb_retract_message_1293@domain.example.com/res1'>
<apply-to id='orig-id-1' xmlns='urn:xmpp:fasten:0'>
<retract xmlns='urn:xmpp:message-retract:0'/>
</apply-to>
</message>
*** User 2022-03-04 11:21:11.621 ***
bOb_retract_message_1293@domain.example.com/res1 in
<message from='alicE_retract_message_1293@domain.example.com/res1' to='bOb_retract_message_1293@domain.example.com/res1' xml:lang='en' type='chat'>
<apply-to id='orig-id-1' xmlns='urn:xmpp:fasten:0'>
<retract xmlns='urn:xmpp:message-retract:0'/>
</apply-to>
<stanza-id by='bOb_retract_message_1293@domain.example.com' id='BMB2MP30M6O1' xmlns='urn:xmpp:sid:0'/>
</message>
Could not find element archive_wait in Config.
*** User 2022-03-04 11:21:11.623 ***
alicE_retract_message_1293@domain.example.com/res1 out
<iq type='set' id='603833b60092e126901d62dc2488fc55'>
<query xmlns='urn:xmpp:mam:2' queryid='q1'>
<x xmlns='jabber:x:data'/>
</query>
</iq>
*** User 2022-03-04 11:21:11.624 ***
alicE_retract_message_1293@domain.example.com/res1 in
<message from='alicE_retract_message_1293@domain.example.com' to='alicE_retract_message_1293@domain.example.com/res1' id='7f0fef79-e286-49bf-a2c5-ad18237f27e9'>
<result queryid='q1' xmlns='urn:xmpp:mam:2' id='BMB2MP25R2O1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:21:11Z' from='alice_retract_message_1293@domain.example.com/res1'/>
<message from='alice_retract_message_1293@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_retract_message_1293@domain.example.com/res1' type='chat'>
<body>OH, HAI!</body>
<origin-id xmlns='urn:xmpp:sid:0' id='orig-id-1'/>
</message>
</forwarded>
</result>
</message>
*** User 2022-03-04 11:21:11.625 ***
alicE_retract_message_1293@domain.example.com/res1 in
<message from='alicE_retract_message_1293@domain.example.com' to='alicE_retract_message_1293@domain.example.com/res1' id='743848e6-ef8d-43e8-9b33-7cd882f98c25'>
<result queryid='q1' xmlns='urn:xmpp:mam:2' id='BMB2MP30M6G1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:21:11Z' from='alice_retract_message_1293@domain.example.com/res1'/>
<message from='alice_retract_message_1293@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' type='chat' to='bOb_retract_message_1293@domain.example.com/res1'>
<apply-to id='orig-id-1' xmlns='urn:xmpp:fasten:0'>
<retract xmlns='urn:xmpp:message-retract:0'/>
</apply-to>
</message>
</forwarded>
</result>
</message>
*** User 2022-03-04 11:21:11.625 ***
alicE_retract_message_1293@domain.example.com/res1 in
<iq from='alicE_retract_message_1293@domain.example.com' to='alicE_retract_message_1293@domain.example.com/res1' id='603833b60092e126901d62dc2488fc55' type='result'>
<fin xmlns='urn:xmpp:mam:2' complete='true'>
<set xmlns='http://jabber.org/protocol/rsm'>
<first index='0'>BMB2MP25R2O1</first>
<last>BMB2MP30M6G1</last>
<count>2</count>
</set>
</fin>
</iq>
*** User 2022-03-04 11:21:11.625 ***
bOb_retract_message_1293@domain.example.com/res1 out
<iq type='set' id='1e9d8abcb5e1530235bdd0282db45cd2'>
<query xmlns='urn:xmpp:mam:2' queryid='q2'>
<x xmlns='jabber:x:data'/>
</query>
</iq>
*** User 2022-03-04 11:21:11.626 ***
bOb_retract_message_1293@domain.example.com/res1 in
<message from='bOb_retract_message_1293@domain.example.com' to='bOb_retract_message_1293@domain.example.com/res1' id='f51266ef-e988-4fa9-a584-f18e091140d9'>
<result queryid='q2' xmlns='urn:xmpp:mam:2' id='BMB2MP25R301'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:21:11Z' from='alice_retract_message_1293@domain.example.com/res1'/>
<message from='alice_retract_message_1293@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' to='bOb_retract_message_1293@domain.example.com/res1' type='chat'>
<body>OH, HAI!</body>
<origin-id xmlns='urn:xmpp:sid:0' id='orig-id-1'/>
</message>
</forwarded>
</result>
</message>
*** User 2022-03-04 11:21:11.626 ***
bOb_retract_message_1293@domain.example.com/res1 in
<message from='bOb_retract_message_1293@domain.example.com' to='bOb_retract_message_1293@domain.example.com/res1' id='33374d28-16b5-4405-98ec-13497e4e84b2'>
<result queryid='q2' xmlns='urn:xmpp:mam:2' id='BMB2MP30M6O1'>
<forwarded xmlns='urn:xmpp:forward:0'>
<delay xmlns='urn:xmpp:delay' stamp='2022-03-04T11:21:11Z' from='alice_retract_message_1293@domain.example.com/res1'/>
<message from='alice_retract_message_1293@domain.example.com/res1' xmlns='jabber:client' xml:lang='en' type='chat' to='bOb_retract_message_1293@domain.example.com/res1'>
<apply-to id='orig-id-1' xmlns='urn:xmpp:fasten:0'>
<retract xmlns='urn:xmpp:message-retract:0'/>
</apply-to>
</message>
</forwarded>
</result>
</message>
*** User 2022-03-04 11:21:11.626 ***
bOb_retract_message_1293@domain.example.com/res1 in
<iq from='bOb_retract_message_1293@domain.example.com' to='bOb_retract_message_1293@domain.example.com/res1' id='1e9d8abcb5e1530235bdd0282db45cd2' type='result'>
<fin xmlns='urn:xmpp:mam:2' complete='true'>
<set xmlns='http://jabber.org/protocol/rsm'>
<first index='0'>BMB2MP25R301</first>
<last>BMB2MP30M6O1</last>
<count>2</count>
</set>
</fin>
</iq>
*** User 2022-03-04 11:21:11.626 ***
bOb_retract_message_1293@domain.example.com/res1 out
</stream:stream>
*** User 2022-03-04 11:21:11.627 ***
bOb_retract_message_1293@domain.example.com/res1 in
</stream:stream>
*** User 2022-03-04 11:21:11.627 ***
alicE_retract_message_1293@domain.example.com/res1 out
</stream:stream>
*** User 2022-03-04 11:21:11.627 ***
alicE_retract_message_1293@domain.example.com/res1 in
</stream:stream>
=== Ended at 2022-03-04 11:21:11
=== successfully completed test case
=== === Returned value: ok