=== Test case: mod_global_distrib_SUITE:test_pm_with_ungraceful_reconnection_to_different_server/1 (click for source code) === Config value: [{nodes_key,<<"localhost.bis#{nodes}">>}, {escalus_user_db,xmpp}, {extra_config,#{redis => #{refresh_after => 3600}}}, {watchdog,<0.34408.0>}, {add_advertised_endpoints,[]}, {extra_config,#{}}, {preset,"internal_mnesia"}, {mim_data_dir,"/home/circleci/project/big_tests/tests/mod_global_distrib_SUITE_data"}, {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@ab4da8ac41c7.2024-04-15_15.52.42/big_tests.tests.mod_global_distrib_SUITE.logs/run.2024-04-15_16.01.47/mod_global_distrib_suite.test_pm_with_ungraceful_reconnection_to_different_server.html"}, {tc_group_properties,[{name,mod_global_distrib}]}, {tc_group_path,[]}, {data_dir,"/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/mod_global_distrib_SUITE_data/"}, {priv_dir,"/home/circleci/project/big_tests/ct_report/ct_run.test@ab4da8ac41c7.2024-04-15_15.52.42/big_tests.tests.mod_global_distrib_SUITE.logs/run.2024-04-15_16.01.47/log_private/"}, {{saved_modules,mongooseim@localhost,<<"localhost">>}, #{mod_vcard => #{matches => 30, host => {prefix,<<"vjud.">>}, search => true,backend => mnesia,iqdisc => parallel}, mod_roster => #{backend => mnesia,iqdisc => one_queue,versioning => false, store_current_id => false}, mod_sic => #{iqdisc => one_queue}, mod_amp => #{}, mod_register => #{access => register,iqdisc => one_queue, registration_watchers => [],password_strength => 0, ip_access => [{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]}, mod_disco => #{iqdisc => one_queue,users_can_see_hidden_services => false, server_info => [],extra_domains => []}, mod_presence => #{}, mod_stream_management => #{buffer => true,ack => true,backend => mnesia, stale_h => #{enabled => false,repeat_after => 1800,geriatric => 3600}, buffer_max => 100,ack_freq => 1,resume_timeout => 600}, mod_adhoc => #{iqdisc => one_queue,report_commands_node => false}, mod_cache_users => #{strategy => fifo,number_of_segments => 5,time_to_live => 2}, mod_carboncopy => #{iqdisc => no_queue}, mod_bosh => #{backend => mnesia,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}}}, {{saved_modules,mongooseim@localhost,<<"localhost.bis">>}, #{mod_vcard => #{matches => 30, host => {prefix,<<"vjud.">>}, search => true,backend => mnesia,iqdisc => parallel}, mod_roster => #{backend => mnesia,iqdisc => one_queue,versioning => false, store_current_id => false}, mod_sic => #{iqdisc => one_queue}, mod_amp => #{}, mod_register => #{access => register,iqdisc => one_queue, registration_watchers => [],password_strength => 0, ip_access => [{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]}, mod_disco => #{iqdisc => one_queue,users_can_see_hidden_services => false, server_info => [],extra_domains => []}, mod_presence => #{}, mod_stream_management => #{buffer => true,ack => true,backend => mnesia, stale_h => #{enabled => false,repeat_after => 1800,geriatric => 3600}, buffer_max => 100,ack_freq => 1,resume_timeout => 600}, mod_adhoc => #{iqdisc => one_queue,report_commands_node => false}, mod_cache_users => #{strategy => fifo,number_of_segments => 5,time_to_live => 2}, mod_carboncopy => #{iqdisc => no_queue}, mod_bosh => #{backend => mnesia,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}}}, {{saved_modules,mongooseim2@localhost,<<"localhost">>}, #{mod_vcard => #{matches => 30, host => {prefix,<<"vjud.">>}, search => true,backend => mnesia,iqdisc => parallel}, mod_roster => #{backend => mnesia,iqdisc => one_queue,versioning => false, store_current_id => false}, mod_sic => #{iqdisc => one_queue}, mod_register => #{access => register,iqdisc => one_queue, registration_watchers => [],password_strength => 0, ip_access => [{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]}, mod_disco => #{iqdisc => one_queue,users_can_see_hidden_services => false, server_info => [],extra_domains => []}, mod_presence => #{}, mod_stream_management => #{buffer => true,ack => true,backend => mnesia, stale_h => #{enabled => false,repeat_after => 1800,geriatric => 3600}, buffer_max => 100,ack_freq => 1,resume_timeout => 600}, mod_adhoc => #{iqdisc => one_queue,report_commands_node => false}, mod_carboncopy => #{iqdisc => no_queue}, mod_bosh => #{backend => mnesia,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}}}, {{saved_modules,mongooseim2@localhost,<<"localhost.bis">>}, #{mod_vcard => #{matches => 30, host => {prefix,<<"vjud.">>}, search => true,backend => mnesia,iqdisc => parallel}, mod_roster => #{backend => mnesia,iqdisc => one_queue,versioning => false, store_current_id => false}, mod_sic => #{iqdisc => one_queue}, mod_register => #{access => register,iqdisc => one_queue, registration_watchers => [],password_strength => 0, ip_access => [{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]}, mod_disco => #{iqdisc => one_queue,users_can_see_hidden_services => false, server_info => [],extra_domains => []}, mod_presence => #{}, mod_stream_management => #{buffer => true,ack => true,backend => mnesia, stale_h => #{enabled => false,repeat_after => 1800,geriatric => 3600}, buffer_max => 100,ack_freq => 1,resume_timeout => 600}, mod_adhoc => #{iqdisc => one_queue,report_commands_node => false}, mod_carboncopy => #{iqdisc => no_queue}, mod_bosh => #{backend => mnesia,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}}}, {{saved_modules,reg1@localhost,<<"localhost">>}, #{mod_vcard => #{matches => 30, host => {prefix,<<"vjud.">>}, search => true,backend => mnesia,iqdisc => parallel}, mod_roster => #{backend => mnesia,iqdisc => one_queue,versioning => false, store_current_id => false}, mod_sic => #{iqdisc => one_queue}, mod_register => #{access => register,iqdisc => one_queue, registration_watchers => [],password_strength => 0, ip_access => [{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]}, mod_disco => #{iqdisc => one_queue,users_can_see_hidden_services => false, server_info => [],extra_domains => []}, mod_presence => #{}, mod_stream_management => #{buffer => true,ack => true,backend => mnesia, stale_h => #{enabled => false,repeat_after => 1800,geriatric => 3600}, buffer_max => 100,ack_freq => 1,resume_timeout => 600}, mod_adhoc => #{iqdisc => one_queue,report_commands_node => false}, mod_cache_users => #{strategy => fifo,number_of_segments => 3,time_to_live => 480}, mod_carboncopy => #{iqdisc => no_queue}, mod_bosh => #{backend => mnesia,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}}}] === Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@ab4da8ac41c7.2024-04-15_15.52.42" === Started at 2024-04-15 16:01:52
*** User 2024-04-15 16:01:53.007 ***🔗 eve_unnamed_1216@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:53.007 ***🔗 eve_unnamed_1216@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='2e6f35ea82bab8a8' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-15 16:01:53.008 ***🔗 eve_unnamed_1216@localhost 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-512</mechanism> <mechanism>SCRAM-SHA-384</mechanism> <mechanism>SCRAM-SHA-256</mechanism> <mechanism>SCRAM-SHA-224</mechanism> <mechanism>SCRAM-SHA-1</mechanism> <mechanism>PLAIN</mechanism> </mechanisms> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2024-04-15 16:01:53.008 ***🔗 eve_unnamed_1216@localhost out <iq type='get' id='3ad015ae80618b762b43243d7635a465'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2024-04-15 16:01:53.008 ***🔗 eve_unnamed_1216@localhost in <iq from='localhost' to='localhost' id='3ad015ae80618b762b43243d7635a465' type='result'> <query xmlns='jabber:iq:register'> <instructions>Choose a username and password to register with this server</instructions> <username/> <password/> </query> </iq>
*** User 2024-04-15 16:01:53.008 ***🔗 eve_unnamed_1216@localhost out <iq type='set' id='8d53f1666b2ef1d9182abaa41a7b5718'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_1216</username> <password>password</password> </query> </iq>
*** User 2024-04-15 16:01:53.027 ***🔗 eve_unnamed_1216@localhost in <iq from='localhost' to='localhost' id='8d53f1666b2ef1d9182abaa41a7b5718' type='result'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_1216</username> <password>password</password> </query> </iq>
*** User 2024-04-15 16:01:53.028 ***🔗 eve_unnamed_1216@localhost out </stream:stream>
*** User 2024-04-15 16:01:53.028 ***🔗 eve_unnamed_1216@localhost in </stream:stream>
*** User 2024-04-15 16:01:53.030 ***🔗 eve_unnamed_1216@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:53.030 ***🔗 eve_unnamed_1216@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3c0b64d674478689' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-15 16:01:53.030 ***🔗 eve_unnamed_1216@localhost 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 2024-04-15 16:01:53.031 ***🔗 eve_unnamed_1216@localhost out <iq type='get' id='910cc8d118b6a2c13e2ea867fd67f3d2'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2024-04-15 16:01:53.031 ***🔗 eve_unnamed_1216@localhost in <iq from='localhost' to='localhost' id='910cc8d118b6a2c13e2ea867fd67f3d2' type='result'> <query xmlns='jabber:iq:register'> <instructions>Choose a username and password to register with this server</instructions> <username/> <password/> </query> </iq>
*** User 2024-04-15 16:01:53.031 ***🔗 eve_unnamed_1216@localhost out <iq type='set' id='8dc47c2cda3744c136122d3833c99c61'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_1216</username> <password>password</password> </query> </iq>
*** User 2024-04-15 16:01:53.032 ***🔗 eve_unnamed_1216@localhost in <iq from='localhost' to='localhost' id='8dc47c2cda3744c136122d3833c99c61' type='result'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_1216</username> <password>password</password> </query> </iq>
*** User 2024-04-15 16:01:53.032 ***🔗 eve_unnamed_1216@localhost out </stream:stream>
*** User 2024-04-15 16:01:53.033 ***🔗 eve_unnamed_1216@localhost in </stream:stream>
*** User 2024-04-15 16:01:53.035 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:53.035 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='6944666d0b8fc0f9' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-15 16:01:53.035 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost 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 2024-04-15 16:01:53.036 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost out <iq type='get' id='b9f6bd132880de276a567cbe5f25fc29'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2024-04-15 16:01:53.036 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost in <iq from='localhost' to='localhost' id='b9f6bd132880de276a567cbe5f25fc29' type='result'> <query xmlns='jabber:iq:register'> <instructions>Choose a username and password to register with this server</instructions> <username/> <password/> </query> </iq>
*** User 2024-04-15 16:01:53.036 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost out <iq type='set' id='38f64e780bc8c2b6bd0e25f6accf44a8'> <query xmlns='jabber:iq:register'> <username>alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217</username> <password>matygrysa</password> </query> </iq>
*** User 2024-04-15 16:01:53.037 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost in <iq from='localhost' to='localhost' id='38f64e780bc8c2b6bd0e25f6accf44a8' type='result'> <query xmlns='jabber:iq:register'> <username>alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217</username> <password>matygrysa</password> </query> </iq>
*** User 2024-04-15 16:01:53.037 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost out </stream:stream>
*** User 2024-04-15 16:01:53.038 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost in </stream:stream>
*** User 2024-04-15 16:01:53.038 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:53.039 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3e470d4b5e638498' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-15 16:01:53.039 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@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 2024-04-15 16:01:53.039 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3Rlc3RfcG1fd2l0aF91bmdyYWNlZnVsX3JlY29ubmVjdGlvbl90b19kaWZmZXJlbnRfc2VydmVyXzEyMTcAbWF0eWdyeXNh</auth>
*** User 2024-04-15 16:01:53.040 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-15 16:01:53.040 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:53.040 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='1082b21d0d58974c' from='localhost' version='1.0' xml:lang='en' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost'>
*** User 2024-04-15 16:01:53.040 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@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 2024-04-15 16:01:53.040 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 out <iq type='set' id='2bf13d4511bfae83b84845200320c9e8'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2024-04-15 16:01:53.040 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 in <iq id='2bf13d4511bfae83b84845200320c9e8' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1</jid> </bind> </iq>
*** User 2024-04-15 16:01:53.040 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 out <iq type='set' id='cbf1af2b30664eaaa64c037765f37541'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:53.042 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 in <iq from='localhost' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1' id='cbf1af2b30664eaaa64c037765f37541' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:53.042 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 out <presence/>
*** User 2024-04-15 16:01:53.043 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 in <presence from='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1'/>
*** User 2024-04-15 16:01:53.043 ***🔗 eve_unnamed_1216@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:53.044 ***🔗 eve_unnamed_1216@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='51829764c6f868db' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-15 16:01:53.044 ***🔗 eve_unnamed_1216@localhost 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-512</mechanism> <mechanism>SCRAM-SHA-384</mechanism> <mechanism>SCRAM-SHA-256</mechanism> <mechanism>SCRAM-SHA-224</mechanism> <mechanism>SCRAM-SHA-1</mechanism> <mechanism>PLAIN</mechanism> </mechanisms> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2024-04-15 16:01:53.044 ***🔗 eve_unnamed_1216@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzEyMTYAcGFzc3dvcmQ=</auth>
*** User 2024-04-15 16:01:53.046 ***🔗 eve_unnamed_1216@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-15 16:01:53.046 ***🔗 eve_unnamed_1216@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:53.047 ***🔗 eve_unnamed_1216@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='2cc5478db08ea8df' from='localhost' version='1.0' xml:lang='en' to='eve_unnamed_1216@localhost'>
*** User 2024-04-15 16:01:53.047 ***🔗 eve_unnamed_1216@localhost 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'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2024-04-15 16:01:53.047 ***🔗 eve_unnamed_1216@localhost out <iq type='set' id='f42bca3fe6a3912e32aa844fb5e3e652'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2024-04-15 16:01:53.047 ***🔗 eve_unnamed_1216@localhost in <iq id='f42bca3fe6a3912e32aa844fb5e3e652' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_1216@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2024-04-15 16:01:53.047 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource out <iq type='set' id='50bdd61c55933484e9ac38f0c6e1e9d1'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:53.049 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in <iq from='localhost' to='eve_unnamed_1216@localhost/escalus-default-resource' id='50bdd61c55933484e9ac38f0c6e1e9d1' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:53.049 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource out <enable xmlns='urn:xmpp:sm:3' resume='true'/>
*** User 2024-04-15 16:01:53.050 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in <enabled xmlns='urn:xmpp:sm:3' id='QnuJj4ZFwukQxRKZN4U9RTQoZX6X' resume='true'/>
*** User 2024-04-15 16:01:53.050 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource out <presence/>
*** User 2024-04-15 16:01:53.050 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in <presence from='eve_unnamed_1216@localhost/escalus-default-resource' to='eve_unnamed_1216@localhost/escalus-default-resource'/>
*** User 2024-04-15 16:01:53.051 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 out <message type='chat' to='eve_unnamed_1216@localhost' id='-576460177118323107'> <body>Hi from Europe1!</body> </message>
*** User 2024-04-15 16:01:53.153 ***🔗 waiting for has_route_message is done in 100 miliseconds
*** User 2024-04-15 16:01:53.154 ***🔗 eve_unnamed_1216@localhost/res1 out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:53.154 ***🔗 eve_unnamed_1216@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a5e93991857c85e6' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-15 16:01:53.155 ***🔗 eve_unnamed_1216@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 2024-04-15 16:01:53.155 ***🔗 eve_unnamed_1216@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzEyMTYAcGFzc3dvcmQ=</auth>
*** User 2024-04-15 16:01:53.155 ***🔗 eve_unnamed_1216@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-15 16:01:53.155 ***🔗 eve_unnamed_1216@localhost/res1 out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:53.155 ***🔗 eve_unnamed_1216@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='873cde1e8055fc37' from='localhost' version='1.0' xml:lang='en' to='eve_unnamed_1216@localhost'>
*** User 2024-04-15 16:01:53.155 ***🔗 eve_unnamed_1216@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 2024-04-15 16:01:53.155 ***🔗 eve_unnamed_1216@localhost/res1 out <iq type='set' id='69ade6efa39b0ace4525b349f67b0897'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2024-04-15 16:01:53.156 ***🔗 eve_unnamed_1216@localhost/res1 in <iq id='69ade6efa39b0ace4525b349f67b0897' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_1216@localhost/res1</jid> </bind> </iq>
*** User 2024-04-15 16:01:53.156 ***🔗 eve_unnamed_1216@localhost/res1 out <iq type='set' id='2cbd4fde33324300efc6c5a869c7c52b'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:53.157 ***🔗 eve_unnamed_1216@localhost/res1 in <iq from='localhost' to='eve_unnamed_1216@localhost/res1' id='2cbd4fde33324300efc6c5a869c7c52b' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:53.157 ***🔗 eve_unnamed_1216@localhost/res1 out <presence/>
*** User 2024-04-15 16:01:53.158 ***🔗 eve_unnamed_1216@localhost/res1 in <presence from='eve_unnamed_1216@localhost/res1' to='eve_unnamed_1216@localhost/res1'/>
*** User 2024-04-15 16:01:54.162 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 out <message type='chat' to='eve_unnamed_1216@localhost' id='-576460176007111066'> <body>Hi again from Europe1!</body> </message>
*** User 2024-04-15 16:01:54.162 ***🔗 eve_unnamed_1216@localhost/res1 out <message type='chat' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1'> <body>Hi from Europe!</body> </message>
*** User 2024-04-15 16:01:54.164 ***🔗 eve_unnamed_1216@localhost/res1 in <message from='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1' to='eve_unnamed_1216@localhost' type='chat' id='-576460177118323107'> <body>Hi from Europe1!</body> </message>
*** User 2024-04-15 16:01:54.164 ***🔗 eve_unnamed_1216@localhost/res1 in <message from='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1' to='eve_unnamed_1216@localhost' type='chat' id='-576460176007111066'> <body>Hi again from Europe1!</body> </message>
*** User 2024-04-15 16:01:54.164 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 in <message from='eve_unnamed_1216@localhost/res1' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1' type='chat'> <body>Hi from Europe!</body> </message>
*** User 2024-04-15 16:01:54.164 ***🔗 eve_unnamed_1216@localhost/res1 out </stream:stream>
*** User 2024-04-15 16:01:54.165 ***🔗 eve_unnamed_1216@localhost/res1 in </stream:stream>
*** User 2024-04-15 16:01:54.165 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 out </stream:stream>
*** User 2024-04-15 16:01:54.165 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/res1 in </stream:stream>
*** User 2024-04-15 16:01:54.168 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:54.168 ***🔗 eve_unnamed_1216@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:54.168 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='8dfd1e81202705df' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-15 16:01:54.168 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost 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 2024-04-15 16:01:54.168 ***🔗 eve_unnamed_1216@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='c0738e3ec548e428' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-15 16:01:54.168 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3Rlc3RfcG1fd2l0aF91bmdyYWNlZnVsX3JlY29ubmVjdGlvbl90b19kaWZmZXJlbnRfc2VydmVyXzEyMTcAbWF0eWdyeXNh</auth>
*** User 2024-04-15 16:01:54.168 ***🔗 eve_unnamed_1216@localhost 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-512</mechanism> <mechanism>SCRAM-SHA-384</mechanism> <mechanism>SCRAM-SHA-256</mechanism> <mechanism>SCRAM-SHA-224</mechanism> <mechanism>SCRAM-SHA-1</mechanism> <mechanism>PLAIN</mechanism> </mechanisms> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2024-04-15 16:01:54.169 ***🔗 eve_unnamed_1216@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzEyMTYAcGFzc3dvcmQ=</auth>
*** User 2024-04-15 16:01:54.169 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-15 16:01:54.169 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:54.169 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='848242dde7991a1e' from='localhost' version='1.0' xml:lang='en' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost'>
*** User 2024-04-15 16:01:54.169 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost 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 2024-04-15 16:01:54.169 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost out <iq type='set' id='fb8c5a9ccd5753852dce927bd78a29b0'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2024-04-15 16:01:54.170 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost in <iq id='fb8c5a9ccd5753852dce927bd78a29b0' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2024-04-15 16:01:54.170 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/escalus-default-resource out <iq type='set' id='1a6f076384b5ffd6edf0af8097b337a1'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:54.171 ***🔗 eve_unnamed_1216@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-15 16:01:54.171 ***🔗 eve_unnamed_1216@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:54.171 ***🔗 eve_unnamed_1216@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='927addf952d45fc6' from='localhost' version='1.0' xml:lang='en' to='eve_unnamed_1216@localhost'>
*** User 2024-04-15 16:01:54.171 ***🔗 eve_unnamed_1216@localhost 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'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2024-04-15 16:01:54.171 ***🔗 eve_unnamed_1216@localhost out <iq type='set' id='d6e3b7aaa6dd9b5e1f90740f687d046b'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2024-04-15 16:01:54.171 ***🔗 eve_unnamed_1216@localhost in <iq id='d6e3b7aaa6dd9b5e1f90740f687d046b' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_1216@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2024-04-15 16:01:54.172 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource out <iq type='set' id='8e398c4c2077f429fff56563027bc340'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:54.172 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/escalus-default-resource in <iq from='localhost' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/escalus-default-resource' id='1a6f076384b5ffd6edf0af8097b337a1' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:54.172 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/escalus-default-resource out <iq type='set' id='98c1b152e62e185cfd387a25304d90ef'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2024-04-15 16:01:54.173 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in <iq from='localhost' to='eve_unnamed_1216@localhost/escalus-default-resource' id='8e398c4c2077f429fff56563027bc340' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:54.173 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource out <iq type='set' id='f3afd64bc81b8a63b257312490d124eb'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2024-04-15 16:01:54.173 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/escalus-default-resource in <iq from='' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/escalus-default-resource' id='98c1b152e62e185cfd387a25304d90ef' type='result'/>
*** User 2024-04-15 16:01:54.174 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in <iq from='' to='eve_unnamed_1216@localhost/escalus-default-resource' id='f3afd64bc81b8a63b257312490d124eb' type='result'/>
*** User 2024-04-15 16:01:54.175 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in <stream:error> <conflict xmlns='urn:ietf:params:xml:ns:xmpp-streams'/> <text xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-streams'>User removed</text> </stream:error>
*** User 2024-04-15 16:01:54.175 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in </stream:stream>
*** User 2024-04-15 16:01:54.175 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/escalus-default-resource in <stream:error> <conflict xmlns='urn:ietf:params:xml:ns:xmpp-streams'/> <text xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-streams'>User removed</text> </stream:error>
*** User 2024-04-15 16:01:54.175 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_1217@localhost/escalus-default-resource in </stream:stream>
*** User 2024-04-15 16:01:54.177 ***🔗 eve_unnamed_1216@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:54.177 ***🔗 eve_unnamed_1216@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='ff2f123f224b2a29' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-15 16:01:54.177 ***🔗 eve_unnamed_1216@localhost 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 2024-04-15 16:01:54.178 ***🔗 eve_unnamed_1216@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzEyMTYAcGFzc3dvcmQ=</auth>
*** User 2024-04-15 16:01:54.178 ***🔗 eve_unnamed_1216@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-15 16:01:54.178 ***🔗 eve_unnamed_1216@localhost out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2024-04-15 16:01:54.178 ***🔗 eve_unnamed_1216@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='e43c178b725e7076' from='localhost' version='1.0' xml:lang='en' to='eve_unnamed_1216@localhost'>
*** User 2024-04-15 16:01:54.178 ***🔗 eve_unnamed_1216@localhost 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 2024-04-15 16:01:54.178 ***🔗 eve_unnamed_1216@localhost out <iq type='set' id='e8f0226732ed74ca3e57383107560480'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2024-04-15 16:01:54.179 ***🔗 eve_unnamed_1216@localhost in <iq id='e8f0226732ed74ca3e57383107560480' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_1216@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2024-04-15 16:01:54.179 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource out <iq type='set' id='27035dc12bc17c29c5ad7dca591760a0'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:54.180 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in <iq from='localhost' to='eve_unnamed_1216@localhost/escalus-default-resource' id='27035dc12bc17c29c5ad7dca591760a0' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-15 16:01:54.181 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource out <iq type='set' id='a44c15c5f1667f21e6c32cffa8992b49'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2024-04-15 16:01:54.182 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in <iq from='' to='eve_unnamed_1216@localhost/escalus-default-resource' id='a44c15c5f1667f21e6c32cffa8992b49' type='result'/>
*** User 2024-04-15 16:01:54.183 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in <stream:error> <conflict xmlns='urn:ietf:params:xml:ns:xmpp-streams'/> <text xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-streams'>User removed</text> </stream:error>
*** User 2024-04-15 16:01:54.183 ***🔗 eve_unnamed_1216@localhost/escalus-default-resource in </stream:stream>
=== Ended at 2024-04-15 16:01:54 === successfully completed test case === === Returned value: ok
Test run history | Top level test index | Latest test result