=== Test case: mam_SUITE:muc_light_stored_in_pm_if_allowed_to/1 (click for source code) === Config value: [{basic_group,muc_light}, {configuration,rdbms_async_cache}, {wait_for_parallel_writer,[muc,pm]}, {archive_groupchats,false}, {muc_domain,<<"muclight.@HOST@">>}, {watchdog,<0.3648.1>}, {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.muc_light_stored_in_pm_if_allowed_to.72323.html"}, {tc_group_properties,[{name,rdbms_async_cache_muc_light}]}, {tc_group_path,[]}, {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_groupchats,false}], mod_mam_cache_user => [{pm,true}], mod_mam_muc => [{host,{prefix,<<"muclight.">>}},{archive_groupchats,false}], mod_mam_muc_rdbms_arch => [{no_writer,true}], mod_mam_rdbms_arch => [{no_writer,true}], mod_mam_rdbms_arch_async => [{muc,[{flush_interval,1}]},{pm,[{flush_interval,1}]}], mod_mam_rdbms_prefs => [{pm,true}], mod_mam_rdbms_user => [{muc,true},{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 => [{host,{prefix,<<"muclight.">>}}], 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:49
*** User 2022-01-25 16:26:50.106 *** alicE@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:50.107 *** alicE@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='b4bad3d30c14aba1' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:26:50.107 *** alicE@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:50.107 *** alicE@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFAG1hdHlncnlzYQ==</auth>
*** User 2022-01-25 16:26:50.109 *** alicE@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:26:50.109 *** alicE@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:50.110 *** alicE@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='0ff8caebb7581ad5' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:26:50.110 *** alicE@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:50.110 *** alicE@localhost/res1 out <iq type='set' id='be5b42ea2333df410a5acf10a88e2aa8'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-25 16:26:50.110 *** alicE@localhost/res1 in <iq id='be5b42ea2333df410a5acf10a88e2aa8' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alicE@localhost/res1</jid> </bind> </iq>
*** User 2022-01-25 16:26:50.110 *** alicE@localhost/res1 out <iq type='set' id='e6cb35e548cd526b4bd931563b2275e1'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:26:50.111 *** alicE@localhost/res1 in <iq type='result' id='e6cb35e548cd526b4bd931563b2275e1'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:26:50.111 *** alicE@localhost/res1 out <presence/>
*** User 2022-01-25 16:26:50.114 *** alicE@localhost/res1 in <presence from='alicE@localhost/res1' to='alice@localhost/res1' xml:lang='en'/>
*** User 2022-01-25 16:26:50.114 *** bOb@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:50.115 *** bOb@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='b913be8b2ad3546b' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:26:50.115 *** bOb@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:50.115 *** bOb@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYgBtYWtyb2xpa2E=</auth>
*** User 2022-01-25 16:26:50.117 *** bOb@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:26:50.117 *** bOb@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:50.117 *** bOb@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='83bffa6f3cc4ecbe' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:26:50.117 *** bOb@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:50.118 *** bOb@localhost/res1 out <iq type='set' id='12d03e6f0bda96b63aa5e35f567ccaa2'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-25 16:26:50.118 *** bOb@localhost/res1 in <iq id='12d03e6f0bda96b63aa5e35f567ccaa2' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>bOb@localhost/res1</jid> </bind> </iq>
*** User 2022-01-25 16:26:50.118 *** bOb@localhost/res1 out <iq type='set' id='aa0b0e2d3519efd37aa0c648726d1f62'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:26:50.118 *** bOb@localhost/res1 in <iq type='result' id='aa0b0e2d3519efd37aa0c648726d1f62'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:26:50.118 *** bOb@localhost/res1 out <presence/>
*** User 2022-01-25 16:26:50.121 *** bOb@localhost/res1 in <presence from='bOb@localhost/res1' to='bob@localhost/res1' xml:lang='en'/>
*** User 2022-01-25 16:26:50.121 *** alicE@localhost/res1 out <iq type='set' id='45943cc3a93ecb2dad522ee93e0f7d59' to='testroom_pm@muclight.localhost'> <query xmlns='urn:xmpp:muclight:0#create'> <configuration/> <occupants> <user affiliation='member'>bob@localhost</user> </occupants> </query> </iq>
*** User 2022-01-25 16:26:50.174 *** alicE@localhost/res1 in <message from='testroom_pm@muclight.localhost' to='alice@localhost' id='45943cc3a93ecb2dad522ee93e0f7d59' type='groupchat'> <x xmlns='urn:xmpp:muclight:0#affiliations'> <version>1643-128010-122979</version> <user affiliation='owner'>alice@localhost</user> </x> <body/> <stanza-id by='alice@localhost' id='BLJAHLEI55G1' xmlns='urn:xmpp:sid:0'/> </message>
*** User 2022-01-25 16:26:50.174 *** bOb@localhost/res1 in <message from='testroom_pm@muclight.localhost' to='bob@localhost' id='45943cc3a93ecb2dad522ee93e0f7d59' type='groupchat'> <x xmlns='urn:xmpp:muclight:0#affiliations'> <version>1643-128010-122979</version> <user affiliation='member'>bob@localhost</user> </x> <body/> <stanza-id by='bob@localhost' id='BLJAHLEI55O1' xmlns='urn:xmpp:sid:0'/> </message>
*** User 2022-01-25 16:26:50.174 *** alicE@localhost/res1 in <iq from='testroom_pm@muclight.localhost' to='alicE@localhost/res1' id='45943cc3a93ecb2dad522ee93e0f7d59' type='result'/>
Could not find element archive_wait in Config. Could not find element props in Config.
*** User 2022-01-25 16:26:50.260 *** alicE@localhost/res1 out <iq type='set' id='f30d44677123f2ed1b3a113229ad62f9'> <query xmlns='urn:xmpp:mam:1' queryid='q'> <x xmlns='jabber:x:data'/> </query> </iq>
*** User 2022-01-25 16:26:50.262 *** alicE@localhost/res1 in <message from='alicE@localhost' to='alicE@localhost/res1' id='80c54d84-3e4a-4fcb-840e-f67b30d36f7f'> <result queryid='q' xmlns='urn:xmpp:mam:1' id='BLJAHLEI55G1'> <forwarded xmlns='urn:xmpp:forward:0'> <delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:26:50Z' from='testroom_pm@muclight.localhost'/> <message from='testroom_pm@muclight.localhost' xmlns='jabber:client' to='alice@localhost' id='45943cc3a93ecb2dad522ee93e0f7d59' type='groupchat'> <x xmlns='urn:xmpp:muclight:0#affiliations'> <version>1643-128010-122979</version> <user affiliation='owner'>alice@localhost</user> </x> <body/> </message> </forwarded> </result> </message>
Could not find element props in Config.
*** User 2022-01-25 16:26:50.263 *** alicE@localhost/res1 in <iq from='alicE@localhost' to='alicE@localhost/res1' id='f30d44677123f2ed1b3a113229ad62f9' type='result'> <fin xmlns='urn:xmpp:mam:1' complete='true'> <set xmlns='http://jabber.org/protocol/rsm'> <first index='0'>BLJAHLEI55G1</first> <last>BLJAHLEI55G1</last> <count>1</count> </set> </fin> </iq>
*** User 2022-01-25 16:26:50.263 *** bOb@localhost/res1 out <iq type='set' id='41e5a49eba7e3930ed87c3ae84cd80bb'> <query xmlns='urn:xmpp:mam:1' queryid='q'> <x xmlns='jabber:x:data'/> </query> </iq>
*** User 2022-01-25 16:26:50.265 *** bOb@localhost/res1 in <message from='bOb@localhost' to='bOb@localhost/res1' id='c429f013-ebbb-4617-8c5f-bcfdec585c88'> <result queryid='q' xmlns='urn:xmpp:mam:1' id='BLJAHLEI55O1'> <forwarded xmlns='urn:xmpp:forward:0'> <delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:26:50Z' from='testroom_pm@muclight.localhost'/> <message from='testroom_pm@muclight.localhost' xmlns='jabber:client' to='bob@localhost' id='45943cc3a93ecb2dad522ee93e0f7d59' type='groupchat'> <x xmlns='urn:xmpp:muclight:0#affiliations'> <version>1643-128010-122979</version> <user affiliation='member'>bob@localhost</user> </x> <body/> </message> </forwarded> </result> </message>
*** User 2022-01-25 16:26:50.265 *** bOb@localhost/res1 in <iq from='bOb@localhost' to='bOb@localhost/res1' id='41e5a49eba7e3930ed87c3ae84cd80bb' type='result'> <fin xmlns='urn:xmpp:mam:1' complete='true'> <set xmlns='http://jabber.org/protocol/rsm'> <first index='0'>BLJAHLEI55O1</first> <last>BLJAHLEI55O1</last> <count>1</count> </set> </fin> </iq>
*** User 2022-01-25 16:26:50.265 *** alicE@localhost/res1 out <message to='testroom_pm@muclight.localhost' type='groupchat' id='Id 1'> <body>Msg 1</body> </message>
*** User 2022-01-25 16:26:50.269 *** alicE@localhost/res1 in <message from='testroom_pm@muclight.localhost/alice@localhost' to='alice@localhost' id='Id 1' type='groupchat'> <body>Msg 1</body> <stanza-id by='testroom_pm@muclight.localhost' id='BLJAHLFLBG01' xmlns='urn:xmpp:sid:0'/> <stanza-id by='alice@localhost' id='BLJAHLFLJ3O1' xmlns='urn:xmpp:sid:0'/> </message>
*** User 2022-01-25 16:26:50.269 *** bOb@localhost/res1 in <message from='testroom_pm@muclight.localhost/alice@localhost' to='bob@localhost' id='Id 1' type='groupchat'> <body>Msg 1</body> <stanza-id by='testroom_pm@muclight.localhost' id='BLJAHLFLBG01' xmlns='urn:xmpp:sid:0'/> <stanza-id by='bob@localhost' id='BLJAHLFLQL81' xmlns='urn:xmpp:sid:0'/> </message>
Could not find element archive_wait in Config. Could not find element props in Config.
*** User 2022-01-25 16:26:50.409 *** alicE@localhost/res1 out <iq type='set' id='296d9b312361a5ba74f79c44433ea120'> <query xmlns='urn:xmpp:mam:1' queryid='q'> <x xmlns='jabber:x:data'/> </query> </iq>
*** User 2022-01-25 16:26:50.411 *** alicE@localhost/res1 in <message from='alicE@localhost' to='alicE@localhost/res1' id='ba66a869-52bb-4ccf-ba5a-4c44e066061d'> <result queryid='q' xmlns='urn:xmpp:mam:1' id='BLJAHLEI55G1'> <forwarded xmlns='urn:xmpp:forward:0'> <delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:26:50Z' from='testroom_pm@muclight.localhost'/> <message from='testroom_pm@muclight.localhost' xmlns='jabber:client' to='alice@localhost' id='45943cc3a93ecb2dad522ee93e0f7d59' type='groupchat'> <x xmlns='urn:xmpp:muclight:0#affiliations'> <version>1643-128010-122979</version> <user affiliation='owner'>alice@localhost</user> </x> <body/> </message> </forwarded> </result> </message>
*** User 2022-01-25 16:26:50.411 *** alicE@localhost/res1 in <message from='alicE@localhost' to='alicE@localhost/res1' id='1dbed561-5f41-4fcb-a5b9-921a98a0c96a'> <result queryid='q' xmlns='urn:xmpp:mam:1' id='BLJAHLFLJ3O1'> <forwarded xmlns='urn:xmpp:forward:0'> <delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:26:50Z' from='testroom_pm@muclight.localhost/alice@localhost'/> <message from='testroom_pm@muclight.localhost/alice@localhost' xmlns='jabber:client' to='alice@localhost' id='Id 1' type='groupchat'> <body>Msg 1</body> <stanza-id by='testroom_pm@muclight.localhost' id='BLJAHLFLBG01' xmlns='urn:xmpp:sid:0'/> </message> </forwarded> </result> </message>
Could not find element props in Config.
*** User 2022-01-25 16:26:50.411 *** alicE@localhost/res1 in <iq from='alicE@localhost' to='alicE@localhost/res1' id='296d9b312361a5ba74f79c44433ea120' type='result'> <fin xmlns='urn:xmpp:mam:1' complete='true'> <set xmlns='http://jabber.org/protocol/rsm'> <first index='0'>BLJAHLEI55G1</first> <last>BLJAHLFLJ3O1</last> <count>2</count> </set> </fin> </iq>
*** User 2022-01-25 16:26:50.412 *** bOb@localhost/res1 out <iq type='set' id='d7e376dc7c11d7ab8dc7ab78046a2d04'> <query xmlns='urn:xmpp:mam:1' queryid='q'> <x xmlns='jabber:x:data'/> </query> </iq>
*** User 2022-01-25 16:26:50.414 *** bOb@localhost/res1 in <message from='bOb@localhost' to='bOb@localhost/res1' id='869878a8-3f48-46bb-934d-d11547d0333a'> <result queryid='q' xmlns='urn:xmpp:mam:1' id='BLJAHLEI55O1'> <forwarded xmlns='urn:xmpp:forward:0'> <delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:26:50Z' from='testroom_pm@muclight.localhost'/> <message from='testroom_pm@muclight.localhost' xmlns='jabber:client' to='bob@localhost' id='45943cc3a93ecb2dad522ee93e0f7d59' type='groupchat'> <x xmlns='urn:xmpp:muclight:0#affiliations'> <version>1643-128010-122979</version> <user affiliation='member'>bob@localhost</user> </x> <body/> </message> </forwarded> </result> </message>
*** User 2022-01-25 16:26:50.414 *** bOb@localhost/res1 in <message from='bOb@localhost' to='bOb@localhost/res1' id='489a8932-f7da-4631-afcc-e665d777a5ea'> <result queryid='q' xmlns='urn:xmpp:mam:1' id='BLJAHLFLQL81'> <forwarded xmlns='urn:xmpp:forward:0'> <delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:26:50Z' from='testroom_pm@muclight.localhost/alice@localhost'/> <message from='testroom_pm@muclight.localhost/alice@localhost' xmlns='jabber:client' to='bob@localhost' id='Id 1' type='groupchat'> <body>Msg 1</body> <stanza-id by='testroom_pm@muclight.localhost' id='BLJAHLFLBG01' xmlns='urn:xmpp:sid:0'/> </message> </forwarded> </result> </message>
*** User 2022-01-25 16:26:50.414 *** bOb@localhost/res1 in <iq from='bOb@localhost' to='bOb@localhost/res1' id='d7e376dc7c11d7ab8dc7ab78046a2d04' type='result'> <fin xmlns='urn:xmpp:mam:1' complete='true'> <set xmlns='http://jabber.org/protocol/rsm'> <first index='0'>BLJAHLEI55O1</first> <last>BLJAHLFLQL81</last> <count>2</count> </set> </fin> </iq>
*** User 2022-01-25 16:26:50.414 *** bOb@localhost/res1 out </stream:stream>
*** User 2022-01-25 16:26:50.415 *** bOb@localhost/res1 in </stream:stream>
*** User 2022-01-25 16:26:50.415 *** alicE@localhost/res1 out </stream:stream>
*** User 2022-01-25 16:26:50.415 *** alicE@localhost/res1 in </stream:stream>
=== Ended at 2022-01-25 16:26:50 === successfully completed test case === === Returned value: ok
Test run history | Top level test index | Latest test result