=== Test case: carboncopy_SUITE:normal_message_with_csn_is_carbon_copied/1 (click for source code)
=== Config value:
[{watchdog,<0.10346.0>},
{preset,"odbc_mssql_mnesia"},
{mim_data_dir,"/home/circleci/project/big_tests/tests/carboncopy_SUITE_data"},
{tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@e84896a28784.2023-12-20_12.31.47/big_tests.tests.carboncopy_SUITE.logs/run.2023-12-20_12.32.34/carboncopy_suite.normal_message_with_csn_is_carbon_copied.17795.html"},
{tc_group_properties,[{name,one2one},parallel]},
{tc_group_path,[]},
{data_dir,"/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/carboncopy_SUITE_data/"},
{priv_dir,"/home/circleci/project/big_tests/ct_report/ct_run.test@e84896a28784.2023-12-20_12.31.47/big_tests.tests.carboncopy_SUITE.logs/run.2023-12-20_12.32.34/log_private/"}]
=== Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@e84896a28784.2023-12-20_12.31.47"
=== Started at 2023-12-20 12:32:34
*** User 2023-12-20 12:32:34.283 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2023-12-20 12:32:34.283 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='00a253c4b9b868d4' from='localhost' version='1.0' xml:lang='en'>
*** User 2023-12-20 12:32:34.284 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/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 2023-12-20 12:32:34.284 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX25vcm1hbF9tZXNzYWdlX3dpdGhfY3NuX2lzX2NhcmJvbl9jb3BpZWRfNTk1AG1hdHlncnlzYQ==</auth>
*** User 2023-12-20 12:32:34.285 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2023-12-20 12:32:34.285 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2023-12-20 12:32:34.285 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='8300a7fbaae64363' from='localhost' version='1.0' xml:lang='en' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost'>
*** User 2023-12-20 12:32:34.286 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/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 2023-12-20 12:32:34.286 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<iq type='set' id='b9d983074ac28860f7bfa19fe759606f'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2023-12-20 12:32:34.286 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<iq id='b9d983074ac28860f7bfa19fe759606f' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1</jid>
</bind>
</iq>
*** User 2023-12-20 12:32:34.286 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<iq type='set' id='f49169dac2fe8a74d312e775e946f00d'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2023-12-20 12:32:34.287 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<iq from='localhost' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1' id='f49169dac2fe8a74d312e775e946f00d' type='result'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2023-12-20 12:32:34.288 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<presence/>
*** User 2023-12-20 12:32:34.289 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<presence from='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1'/>
*** User 2023-12-20 12:32:34.290 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res2 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2023-12-20 12:32:34.290 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res2 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='dea47833536c8fcd' from='localhost' version='1.0' xml:lang='en'>
*** User 2023-12-20 12:32:34.290 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res2 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 2023-12-20 12:32:34.290 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res2 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX25vcm1hbF9tZXNzYWdlX3dpdGhfY3NuX2lzX2NhcmJvbl9jb3BpZWRfNTk1AG1hdHlncnlzYQ==</auth>
*** User 2023-12-20 12:32:34.292 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res2 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2023-12-20 12:32:34.292 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res2 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2023-12-20 12:32:34.292 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res2 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='17a71c84cc143464' from='localhost' version='1.0' xml:lang='en' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost'>
*** User 2023-12-20 12:32:34.292 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res2 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 2023-12-20 12:32:34.292 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res2 out
<iq type='set' id='5fa945cdcba00c06983953aac39be4b6'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res2</resource>
</bind>
</iq>
*** User 2023-12-20 12:32:34.293 ***🔗
alicE_normal_message_with_csn_is_carbon_copied_595@localhost/res2 in
<iq id='5fa945cdcba00c06983953aac39be4b6' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2</jid>
</bind>
</iq>
*** User 2023-12-20 12:32:34.293 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2 out
<iq type='set' id='d7c4a52464dc2a2462b92ae4a60a4c68'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2023-12-20 12:32:34.293 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2 in
<iq from='localhost' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2' id='d7c4a52464dc2a2462b92ae4a60a4c68' type='result'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2023-12-20 12:32:34.294 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2 out
<presence/>
*** User 2023-12-20 12:32:34.295 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2 in
<presence from='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2'/>
*** User 2023-12-20 12:32:34.295 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2 in
<presence from='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2'>
<delay xmlns='urn:xmpp:delay' stamp='2023-12-20T12:32:34.289174Z' from='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1'/>
</presence>
*** User 2023-12-20 12:32:34.296 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<presence from='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1'/>
*** User 2023-12-20 12:32:34.296 ***🔗
bOb_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2023-12-20 12:32:34.297 ***🔗
bOb_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='52bbd67e98ac2da9' from='localhost' version='1.0' xml:lang='en'>
*** User 2023-12-20 12:32:34.297 ***🔗
bOb_normal_message_with_csn_is_carbon_copied_595@localhost/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 2023-12-20 12:32:34.297 ***🔗
bOb_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9ub3JtYWxfbWVzc2FnZV93aXRoX2Nzbl9pc19jYXJib25fY29waWVkXzU5NQBtYWtyb2xpa2E=</auth>
*** User 2023-12-20 12:32:34.303 ***🔗
bOb_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2023-12-20 12:32:34.304 ***🔗
bOb_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2023-12-20 12:32:34.304 ***🔗
bOb_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='1775a8c2f072789a' from='localhost' version='1.0' xml:lang='en' to='bob_normal_message_with_csn_is_carbon_copied_595@localhost'>
*** User 2023-12-20 12:32:34.304 ***🔗
bOb_normal_message_with_csn_is_carbon_copied_595@localhost/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 2023-12-20 12:32:34.304 ***🔗
bOb_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<iq type='set' id='086911d4e637b9315d964f212922d965'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<resource>res1</resource>
</bind>
</iq>
*** User 2023-12-20 12:32:34.304 ***🔗
bOb_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<iq id='086911d4e637b9315d964f212922d965' type='result'>
<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
<jid>bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1</jid>
</bind>
</iq>
*** User 2023-12-20 12:32:34.305 ***🔗
bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<iq type='set' id='571591e4b361d7cab37dcc91cefc2c62'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2023-12-20 12:32:34.305 ***🔗
bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<iq from='localhost' to='bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1' id='571591e4b361d7cab37dcc91cefc2c62' type='result'>
<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>
*** User 2023-12-20 12:32:34.305 ***🔗
bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<presence/>
*** User 2023-12-20 12:32:34.307 ***🔗
bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<presence from='bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1' to='bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1'/>
*** User 2023-12-20 12:32:34.307 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<iq xmlns='jabber:client' type='set' id='cb44a890eeec2644aae2b1eed50001ef'>
<enable xmlns='urn:xmpp:carbons:2'/>
</iq>
*** User 2023-12-20 12:32:34.307 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<iq from='alice_normal_message_with_csn_is_carbon_copied_595@localhost' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1' id='cb44a890eeec2644aae2b1eed50001ef' type='result'/>
*** User 2023-12-20 12:32:34.308 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2 out
<iq xmlns='jabber:client' type='set' id='6e08760384b90040093b6f8d14f1ec73'>
<enable xmlns='urn:xmpp:carbons:2'/>
</iq>
*** User 2023-12-20 12:32:34.308 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2 in
<iq from='alice_normal_message_with_csn_is_carbon_copied_595@localhost' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2' id='6e08760384b90040093b6f8d14f1ec73' type='result'/>
*** User 2023-12-20 12:32:34.312 ***🔗
bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
<message type='normal' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2'>
<stateName xmlns='http://jabber.org/protocol/chatstates'/>
</message>
*** User 2023-12-20 12:32:34.313 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2 in
<message from='bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2' type='normal'>
<stateName xmlns='http://jabber.org/protocol/chatstates'/>
</message>
*** User 2023-12-20 12:32:34.313 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
<message from='alice_normal_message_with_csn_is_carbon_copied_595@localhost' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1' xmlns='jabber:client' type='normal'>
<received xmlns='urn:xmpp:carbons:2'>
<forwarded xmlns='urn:xmpp:forward:0'>
<message from='bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1' to='alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2' type='normal' xmlns='jabber:client'>
<stateName xmlns='http://jabber.org/protocol/chatstates'/>
</message>
</forwarded>
</received>
</message>
*** User 2023-12-20 12:32:34.313 ***🔗
bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
</stream:stream>
*** User 2023-12-20 12:32:34.313 ***🔗
bob_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
</stream:stream>
*** User 2023-12-20 12:32:34.314 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2 out
</stream:stream>
*** User 2023-12-20 12:32:34.314 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res2 in
</stream:stream>
*** User 2023-12-20 12:32:34.314 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1 out
</stream:stream>
*** User 2023-12-20 12:32:34.314 ***🔗
alice_normal_message_with_csn_is_carbon_copied_595@localhost/res1 in
</stream:stream>
=== Ended at 2023-12-20 12:32:34
=== successfully completed test case
=== === Returned value: ok