=== Test case: mod_global_distrib_SUITE:test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first/1 (click for source code) === Config value: [{nodes_key,<<"localhost.bis#{nodes}">>}, {escalus_user_db,xmpp}, {extra_config,#{redis => #{refresh_after => 3600}}}, {watchdog,<0.60450.0>}, {add_advertised_endpoints,[]}, {extra_config,#{}}, {preset,"pgsql_cets"}, {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@2ed2b07c4324.2024-04-18_10.56.18/big_tests.tests.mod_global_distrib_SUITE.logs/run.2024-04-18_11.04.40/mod_global_distrib_suite.test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first.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@2ed2b07c4324.2024-04-18_10.56.18/big_tests.tests.mod_global_distrib_SUITE.logs/run.2024-04-18_11.04.40/log_private/"}, {{saved_modules,mongooseim@localhost,<<"localhost">>}, #{mod_vcard => #{matches => 30, host => {prefix,<<"vjud.">>}, search => true,iqdisc => parallel,backend => rdbms}, mod_roster => #{iqdisc => one_queue,backend => rdbms,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_amp => #{}, 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 => cets, 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_bosh => #{backend => cets,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}, mod_cache_users => #{strategy => fifo,number_of_segments => 5,time_to_live => 2}, mod_carboncopy => #{iqdisc => no_queue}}}, {{saved_modules,mongooseim@localhost,<<"localhost.bis">>}, #{mod_vcard => #{matches => 30, host => {prefix,<<"vjud.">>}, search => true,iqdisc => parallel,backend => rdbms}, mod_roster => #{iqdisc => one_queue,backend => rdbms,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_amp => #{}, 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 => cets, 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_bosh => #{backend => cets,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}, mod_cache_users => #{strategy => fifo,number_of_segments => 5,time_to_live => 2}, mod_carboncopy => #{iqdisc => no_queue}}}, {{saved_modules,mongooseim2@localhost,<<"localhost">>}, #{mod_vcard => #{matches => 30, host => {prefix,<<"vjud.">>}, search => true,iqdisc => parallel,backend => rdbms}, mod_roster => #{iqdisc => one_queue,backend => rdbms,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 => cets, 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_bosh => #{backend => cets,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}, mod_carboncopy => #{iqdisc => no_queue}}}, {{saved_modules,mongooseim2@localhost,<<"localhost.bis">>}, #{mod_vcard => #{matches => 30, host => {prefix,<<"vjud.">>}, search => true,iqdisc => parallel,backend => rdbms}, mod_roster => #{iqdisc => one_queue,backend => rdbms,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 => cets, 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_bosh => #{backend => cets,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}, mod_carboncopy => #{iqdisc => no_queue}}}, {{saved_modules,reg1@localhost,<<"localhost">>}, #{mod_vcard => #{matches => 30, host => {prefix,<<"vjud.">>}, search => true,iqdisc => parallel,backend => rdbms}, mod_roster => #{iqdisc => one_queue,backend => rdbms,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 => cets, 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_bosh => #{backend => cets,inactivity => 30,max_pause => 120, max_wait => infinity,server_acks => false}, mod_cache_users => #{strategy => fifo,number_of_segments => 3,time_to_live => 480}, mod_carboncopy => #{iqdisc => no_queue}}}] === Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@2ed2b07c4324.2024-04-18_10.56.18" === Started at 2024-04-18 11:04:47
*** User 2024-04-18 11:04:47.577 ***🔗 eve_unnamed_2369@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-18 11:04:47.577 ***🔗 eve_unnamed_2369@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='37795230f79b5a4e' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-18 11:04:47.577 ***🔗 eve_unnamed_2369@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-18 11:04:47.577 ***🔗 eve_unnamed_2369@localhost out <iq type='get' id='72bc07774b2a1e7974c95a3fb0c0d4e1'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2024-04-18 11:04:47.578 ***🔗 eve_unnamed_2369@localhost in <iq from='localhost' to='localhost' id='72bc07774b2a1e7974c95a3fb0c0d4e1' 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-18 11:04:47.578 ***🔗 eve_unnamed_2369@localhost out <iq type='set' id='f43f42552f2a270cf8e15ce62f147a83'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_2369</username> <password>password</password> </query> </iq>
*** User 2024-04-18 11:04:47.599 ***🔗 eve_unnamed_2369@localhost in <iq from='localhost' to='localhost' id='f43f42552f2a270cf8e15ce62f147a83' type='result'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_2369</username> <password>password</password> </query> </iq>
*** User 2024-04-18 11:04:47.599 ***🔗 eve_unnamed_2369@localhost out </stream:stream>
*** User 2024-04-18 11:04:47.600 ***🔗 eve_unnamed_2369@localhost in </stream:stream>
*** User 2024-04-18 11:04:47.602 ***🔗 eve_unnamed_2369@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-18 11:04:47.602 ***🔗 eve_unnamed_2369@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='8255384525f21214' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-18 11:04:47.603 ***🔗 eve_unnamed_2369@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-18 11:04:47.603 ***🔗 eve_unnamed_2369@localhost out <iq type='get' id='9a5d8b8e0c2c5cd7c751a8b6498486b1'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2024-04-18 11:04:47.603 ***🔗 eve_unnamed_2369@localhost in <iq from='localhost' to='localhost' id='9a5d8b8e0c2c5cd7c751a8b6498486b1' 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-18 11:04:47.603 ***🔗 eve_unnamed_2369@localhost out <iq type='set' id='e733dd9c9d1ec62d8fb2ebcc10eae493'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_2369</username> <password>password</password> </query> </iq>
*** User 2024-04-18 11:04:47.604 ***🔗 eve_unnamed_2369@localhost in <iq from='localhost' to='localhost' id='e733dd9c9d1ec62d8fb2ebcc10eae493' type='error'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_2369</username> <password>password</password> </query> <error code='409' type='cancel'> <conflict xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/> </error> </iq>
*** User 2024-04-18 11:04:47.604 ***🔗 eve_unnamed_2369@localhost out </stream:stream>
*** User 2024-04-18 11:04:47.604 ***🔗 eve_unnamed_2369@localhost in </stream:stream>
*** System report during mod_global_distrib_SUITE:test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first/1 in mod_global_distrib 2024-04-18 11:04:47.604 ***🔗 =INFO REPORT==== 18-Apr-2024::11:04:47.604773 === user already existed:eve_unnamed_2369 password
*** User 2024-04-18 11:04:47.607 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:47.607 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a350e42fea3e4cb0' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-18 11:04:47.607 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:47.608 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost out <iq type='get' id='c4c1748b78d743ca77b1f2815bfe1a35'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2024-04-18 11:04:47.608 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost in <iq from='localhost' to='localhost' id='c4c1748b78d743ca77b1f2815bfe1a35' 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-18 11:04:47.608 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost out <iq type='set' id='e1c1602baab01653392b175b63278141'> <query xmlns='jabber:iq:register'> <username>alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371</username> <password>matygrysa</password> </query> </iq>
*** User 2024-04-18 11:04:47.610 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost in <iq from='localhost' to='localhost' id='e1c1602baab01653392b175b63278141' type='result'> <query xmlns='jabber:iq:register'> <username>alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371</username> <password>matygrysa</password> </query> </iq>
*** User 2024-04-18 11:04:47.610 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost out </stream:stream>
*** User 2024-04-18 11:04:47.610 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost in </stream:stream>
*** User 2024-04-18 11:04:47.611 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:47.611 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d23599d7c721b445' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-18 11:04:47.611 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:47.611 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3Rlc3RfcG1fd2l0aF91bmdyYWNlZnVsX3JlY29ubmVjdGlvbl90b19kaWZmZXJlbnRfc2VydmVyX3dpdGhfZXVyb3BlX3JlZnJlc2hlc19maXJzdF8yMzcxAG1hdHlncnlzYQ==</auth>
*** User 2024-04-18 11:04:47.612 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-18 11:04:47.612 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:47.612 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a9d00bcaf31b3f5e' from='localhost' version='1.0' xml:lang='en' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost'>
*** User 2024-04-18 11:04:47.612 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:47.613 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 out <iq type='set' id='da66b93adc03a003b53b4cedac0e3eb0'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2024-04-18 11:04:47.613 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 in <iq id='da66b93adc03a003b53b4cedac0e3eb0' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1</jid> </bind> </iq>
*** User 2024-04-18 11:04:47.613 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 out <iq type='set' id='3d0108aeda270fb927321c1282fa42ef'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-18 11:04:47.615 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 in <iq from='localhost' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1' id='3d0108aeda270fb927321c1282fa42ef' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-18 11:04:47.615 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 out <presence/>
*** User 2024-04-18 11:04:47.616 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 in <presence from='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1'/>
*** User 2024-04-18 11:04:47.616 ***🔗 eve_unnamed_2369@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-18 11:04:47.617 ***🔗 eve_unnamed_2369@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a73e8705d7c04e08' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-18 11:04:47.617 ***🔗 eve_unnamed_2369@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-18 11:04:47.617 ***🔗 eve_unnamed_2369@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzIzNjkAcGFzc3dvcmQ=</auth>
*** User 2024-04-18 11:04:47.620 ***🔗 eve_unnamed_2369@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-18 11:04:47.620 ***🔗 eve_unnamed_2369@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-18 11:04:47.621 ***🔗 eve_unnamed_2369@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='f1c3aaf5b0101f75' from='localhost' version='1.0' xml:lang='en' to='eve_unnamed_2369@localhost'>
*** User 2024-04-18 11:04:47.621 ***🔗 eve_unnamed_2369@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-18 11:04:47.621 ***🔗 eve_unnamed_2369@localhost out <iq type='set' id='5403ce732bb4f5a8e44ae6fee7c89e7a'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2024-04-18 11:04:47.621 ***🔗 eve_unnamed_2369@localhost in <iq id='5403ce732bb4f5a8e44ae6fee7c89e7a' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_2369@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2024-04-18 11:04:47.621 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource out <iq type='set' id='7e7d620e2d6b302a09d8bc8579d23043'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-18 11:04:47.622 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource in <iq from='localhost' to='eve_unnamed_2369@localhost/escalus-default-resource' id='7e7d620e2d6b302a09d8bc8579d23043' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-18 11:04:47.623 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource out <enable xmlns='urn:xmpp:sm:3' resume='true'/>
*** User 2024-04-18 11:04:47.623 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource in <enabled xmlns='urn:xmpp:sm:3' id='LeYzQpUu8nMZEtCocdBsGzPUh+Ls' resume='true'/>
*** User 2024-04-18 11:04:47.623 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource out <presence/>
*** User 2024-04-18 11:04:47.624 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource in <presence from='eve_unnamed_2369@localhost/escalus-default-resource' to='eve_unnamed_2369@localhost/escalus-default-resource'/>
*** User 2024-04-18 11:04:47.624 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 out <message type='chat' to='eve_unnamed_2369@localhost' id='-576460219238061479'> <body>Hi from Europe1!</body> </message>
*** User 2024-04-18 11:04:47.726 ***🔗 waiting for has_route_message is done in 100 miliseconds
*** User 2024-04-18 11:04:47.727 ***🔗 eve_unnamed_2369@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-18 11:04:47.727 ***🔗 eve_unnamed_2369@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='03653ec8968b9c20' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-18 11:04:47.727 ***🔗 eve_unnamed_2369@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-18 11:04:47.727 ***🔗 eve_unnamed_2369@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzIzNjkAcGFzc3dvcmQ=</auth>
*** User 2024-04-18 11:04:47.730 ***🔗 eve_unnamed_2369@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-18 11:04:47.730 ***🔗 eve_unnamed_2369@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-18 11:04:47.731 ***🔗 eve_unnamed_2369@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='fa6eef89f5a8aa00' from='localhost' version='1.0' xml:lang='en' to='eve_unnamed_2369@localhost'>
*** User 2024-04-18 11:04:47.731 ***🔗 eve_unnamed_2369@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-18 11:04:47.731 ***🔗 eve_unnamed_2369@localhost/res1 out <iq type='set' id='7b7abb69e9d93dfaaf6681c502abcfcd'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2024-04-18 11:04:47.731 ***🔗 eve_unnamed_2369@localhost/res1 in <iq id='7b7abb69e9d93dfaaf6681c502abcfcd' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_2369@localhost/res1</jid> </bind> </iq>
*** User 2024-04-18 11:04:47.731 ***🔗 eve_unnamed_2369@localhost/res1 out <iq type='set' id='42d8df70b916f92913ccb94dce1c66fe'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-18 11:04:47.733 ***🔗 eve_unnamed_2369@localhost/res1 in <iq from='localhost' to='eve_unnamed_2369@localhost/res1' id='42d8df70b916f92913ccb94dce1c66fe' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-18 11:04:47.733 ***🔗 eve_unnamed_2369@localhost/res1 out <presence/>
*** User 2024-04-18 11:04:47.734 ***🔗 eve_unnamed_2369@localhost/res1 in <presence from='eve_unnamed_2369@localhost/res1' to='eve_unnamed_2369@localhost/res1'/>
*** User 2024-04-18 11:04:48.741 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 out <message type='chat' to='eve_unnamed_2369@localhost' id='-576460218121234514'> <body>Hi again from Europe1!</body> </message>
*** User 2024-04-18 11:04:48.741 ***🔗 eve_unnamed_2369@localhost/res1 out <message type='chat' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1'> <body>Hi from Europe!</body> </message>
*** User 2024-04-18 11:04:48.743 ***🔗 eve_unnamed_2369@localhost/res1 in <message from='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1' to='eve_unnamed_2369@localhost' type='chat' id='-576460218121234514'> <body>Hi again from Europe1!</body> </message>
*** User 2024-04-18 11:04:48.743 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 in <message from='eve_unnamed_2369@localhost/res1' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1' type='chat'> <body>Hi from Europe!</body> </message>
*** User 2024-04-18 11:04:48.743 ***🔗 eve_unnamed_2369@localhost/res1 out </stream:stream>
*** User 2024-04-18 11:04:48.743 ***🔗 eve_unnamed_2369@localhost/res1 in </stream:stream>
*** User 2024-04-18 11:04:48.743 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 out </stream:stream>
*** User 2024-04-18 11:04:48.744 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/res1 in </stream:stream>
*** User 2024-04-18 11:04:48.747 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:48.747 ***🔗 eve_unnamed_2369@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-18 11:04:48.747 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='b8becd02a719c034' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-18 11:04:48.747 ***🔗 eve_unnamed_2369@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='c5c886453af862ac' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-18 11:04:48.747 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:48.747 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3Rlc3RfcG1fd2l0aF91bmdyYWNlZnVsX3JlY29ubmVjdGlvbl90b19kaWZmZXJlbnRfc2VydmVyX3dpdGhfZXVyb3BlX3JlZnJlc2hlc19maXJzdF8yMzcxAG1hdHlncnlzYQ==</auth>
*** User 2024-04-18 11:04:48.748 ***🔗 eve_unnamed_2369@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-18 11:04:48.748 ***🔗 eve_unnamed_2369@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzIzNjkAcGFzc3dvcmQ=</auth>
*** User 2024-04-18 11:04:48.748 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-18 11:04:48.749 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:48.749 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='e966456e96bf77d0' from='localhost' version='1.0' xml:lang='en' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost'>
*** User 2024-04-18 11:04:48.749 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:48.749 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost out <iq type='set' id='2b6c57c240da82459b2c364b3f97a638'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2024-04-18 11:04:48.749 ***🔗 alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost in <iq id='2b6c57c240da82459b2c364b3f97a638' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2024-04-18 11:04:48.750 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/escalus-default-resource out <iq type='set' id='c493b0365b814e34a51aaaece18cfd62'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-18 11:04:48.751 ***🔗 eve_unnamed_2369@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2024-04-18 11:04:48.751 ***🔗 eve_unnamed_2369@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-18 11:04:48.751 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/escalus-default-resource in <iq from='localhost' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/escalus-default-resource' id='c493b0365b814e34a51aaaece18cfd62' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-18 11:04:48.751 ***🔗 eve_unnamed_2369@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='04d26ca6641ab7d5' from='localhost' version='1.0' xml:lang='en' to='eve_unnamed_2369@localhost'>
*** User 2024-04-18 11:04:48.751 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/escalus-default-resource out <iq type='set' id='17748c9fbe29e6b23793f6037890b18e'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2024-04-18 11:04:48.752 ***🔗 eve_unnamed_2369@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-18 11:04:48.752 ***🔗 eve_unnamed_2369@localhost out <iq type='set' id='74a6a84583d34e408d1a1916711d3531'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2024-04-18 11:04:48.752 ***🔗 eve_unnamed_2369@localhost in <iq id='74a6a84583d34e408d1a1916711d3531' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_2369@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2024-04-18 11:04:48.752 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource out <iq type='set' id='aa8430d8e4beefbddf522d1058267b58'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-18 11:04:48.753 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/escalus-default-resource in <iq from='' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/escalus-default-resource' id='17748c9fbe29e6b23793f6037890b18e' type='result'/>
*** User 2024-04-18 11:04:48.753 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource in <iq from='localhost' to='eve_unnamed_2369@localhost/escalus-default-resource' id='aa8430d8e4beefbddf522d1058267b58' type='result'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2024-04-18 11:04:48.754 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource out <iq type='set' id='d1e845c90bfed602dd50aee597ae456e'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2024-04-18 11:04:48.755 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource in <iq from='' to='eve_unnamed_2369@localhost/escalus-default-resource' id='d1e845c90bfed602dd50aee597ae456e' type='result'/>
*** User 2024-04-18 11:04:48.755 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@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-18 11:04:48.755 ***🔗 alice_test_pm_with_ungraceful_reconnection_to_different_server_with_europe_refreshes_first_2371@localhost/escalus-default-resource in </stream:stream>
*** User 2024-04-18 11:04:48.757 ***🔗 eve_unnamed_2369@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-18 11:04:48.757 ***🔗 eve_unnamed_2369@localhost/escalus-default-resource in </stream:stream>
*** User 2024-04-18 11:04:48.759 ***🔗 eve_unnamed_2369@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-18 11:04:48.760 ***🔗 eve_unnamed_2369@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3d4a92381ce64a0f' from='localhost' version='1.0' xml:lang='en'>
*** User 2024-04-18 11:04:48.760 ***🔗 eve_unnamed_2369@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-18 11:04:48.760 ***🔗 eve_unnamed_2369@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzIzNjkAcGFzc3dvcmQ=</auth>
*** User 2024-04-18 11:04:48.761 ***🔗 eve_unnamed_2369@localhost in <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'> <not-authorized/> </failure>
=== Ended at 2024-04-18 11:04:48 === successfully completed test case === === Returned value: ok
Test run history | Top level test index | Latest test result