=== Test case: mod_global_distrib_SUITE:test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first/1 (click for source code) === Config value: [{nodes_key,<<"localhost.bis#{nodes}">>}, {escalus_user_db,xmpp}, {redis_extra_config,[{refresh_after,3600}]}, {watchdog,<0.15192.1>}, {add_advertised_endpoints,[]}, {extra_config,[]}, {redis_extra_config,[no_opts]}, {mim_data_dir,"/home/circleci/project/big_tests/tests/mod_global_distrib_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.mod_global_distrib_SUITE.logs/run.2022-01-25_16.28.03/mod_global_distrib_suite.test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first.html"}, {tc_group_properties,[{name,mod_global_distrib},{repeat_until_all_ok,3}]}, {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@ebe8a8f9fc53.2022-01-25_16.21.59/big_tests.tests.mod_global_distrib_SUITE.logs/run.2022-01-25_16.28.03/log_private/"}, {{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_muc_commands => [],mod_muc_light_commands => [], 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.">>}}]}}, {{saved_modules,mongooseim@localhost,<<"localhost.bis">>}, #{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_muc_commands => [],mod_muc_light => [], mod_muc_light_commands => [], 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.">>}}]}}, {{saved_modules,ejabberd2@localhost,<<"localhost">>}, #{mod_adhoc => [],mod_bosh => [],mod_carboncopy => [], mod_commands => [], mod_disco => [{users_can_see_hidden_services,false}], mod_muc_commands => [],mod_muc_light_commands => [], 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.">>}}]}}, {{saved_modules,ejabberd2@localhost,<<"localhost.bis">>}, #{mod_adhoc => [],mod_bosh => [],mod_carboncopy => [], mod_commands => [], mod_disco => [{users_can_see_hidden_services,false}], mod_muc_commands => [],mod_muc_light_commands => [], 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.">>}}]}}, {{saved_modules,reg1@localhost,<<"localhost">>}, #{mod_adhoc => [],mod_bosh => [],mod_cache_users => [], mod_carboncopy => [],mod_commands => [], mod_disco => [{users_can_see_hidden_services,false}], mod_muc_commands => [],mod_muc_light_commands => [], 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.">>}}]}}] === 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:28:13
*** User 2022-01-25 16:28:13.422 *** eve_unnamed_1620@localhost 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:28:13.423 *** eve_unnamed_1620@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='587f958c662789c1' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.423 *** eve_unnamed_1620@localhost in <stream:features> <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> <register xmlns='http://jabber.org/features/iq-register'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2022-01-25 16:28:13.423 *** eve_unnamed_1620@localhost out <iq type='get' id='40dd2bb18a0b041b07bc16a914165f10'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-25 16:28:13.423 *** eve_unnamed_1620@localhost in <iq from='localhost' id='40dd2bb18a0b041b07bc16a914165f10' type='result'> <query xmlns='jabber:iq:register'> <instructions>Choose a username and password to register with this server</instructions> <username/> <password/> </query> </iq>
*** User 2022-01-25 16:28:13.423 *** eve_unnamed_1620@localhost out <iq type='set' id='1939cd81a1de5e1dac991c12fb5628ff'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_1620</username> <password>password</password> </query> </iq>
*** User 2022-01-25 16:28:13.464 *** eve_unnamed_1620@localhost in <iq from='localhost' id='1939cd81a1de5e1dac991c12fb5628ff' type='result'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_1620</username> <password>password</password> </query> </iq>
*** User 2022-01-25 16:28:13.465 *** eve_unnamed_1620@localhost out </stream:stream>
*** User 2022-01-25 16:28:13.465 *** eve_unnamed_1620@localhost in </stream:stream>
*** User 2022-01-25 16:28:13.468 *** eve_unnamed_1620@localhost 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:28:13.468 *** eve_unnamed_1620@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='84ff125bb0a0c2f2' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.468 *** eve_unnamed_1620@localhost 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:28:13.468 *** eve_unnamed_1620@localhost out <iq type='get' id='cf4f6e4e95bdc86f058ebee6c9544487'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-25 16:28:13.469 *** eve_unnamed_1620@localhost in <iq from='localhost' id='cf4f6e4e95bdc86f058ebee6c9544487' type='result'> <query xmlns='jabber:iq:register'> <instructions>Choose a username and password to register with this server</instructions> <username/> <password/> </query> </iq>
*** User 2022-01-25 16:28:13.469 *** eve_unnamed_1620@localhost out <iq type='set' id='fc57ede5eff50b09ebb2e1c865304bd6'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_1620</username> <password>password</password> </query> </iq>
*** User 2022-01-25 16:28:13.470 *** eve_unnamed_1620@localhost in <iq from='localhost' id='fc57ede5eff50b09ebb2e1c865304bd6' type='error'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_1620</username> <password>password</password> </query> <error code='409' type='cancel'> <conflict xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/> </error> </iq>
*** User 2022-01-25 16:28:13.470 *** eve_unnamed_1620@localhost out </stream:stream>
*** User 2022-01-25 16:28:13.470 *** eve_unnamed_1620@localhost in </stream:stream>
*** System report during mod_global_distrib_SUITE:test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first/1 in mod_global_distrib 2022-01-25 16:28:13.471 *** =INFO REPORT==== 25-Jan-2022::16:28:13.471012 === user already existed:eve_unnamed_1620 password
*** User 2022-01-25 16:28:13.474 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost 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:28:13.474 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='47b299c399372c67' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.474 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost 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:28:13.474 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost out <iq type='get' id='09721f6788fb67da9994ff509620c245'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-25 16:28:13.474 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost in <iq from='localhost' id='09721f6788fb67da9994ff509620c245' type='result'> <query xmlns='jabber:iq:register'> <instructions>Choose a username and password to register with this server</instructions> <username/> <password/> </query> </iq>
*** User 2022-01-25 16:28:13.475 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost out <iq type='set' id='b4fb577a69b1cbc5e3556683628d212c'> <query xmlns='jabber:iq:register'> <username>alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-25 16:28:13.477 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost in <iq from='localhost' id='b4fb577a69b1cbc5e3556683628d212c' type='result'> <query xmlns='jabber:iq:register'> <username>alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-25 16:28:13.477 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost out </stream:stream>
*** User 2022-01-25 16:28:13.477 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost in </stream:stream>
*** User 2022-01-25 16:28:13.478 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@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:28:13.479 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d0f87476cffa589b' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.479 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@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:28:13.479 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3Rlc3RfcG1fd2l0aF91bmdyYWNlZnVsX3JlY29ubmVjdGlvbl90b19kaWZmZXJlbnRfc2VydmVyX3dpdGhfYXNpYV9yZWZyZXNoZXNfZmlyc3RfMTYyMQBtYXR5Z3J5c2E=</auth>
*** User 2022-01-25 16:28:13.480 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:28:13.480 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@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:28:13.480 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='53ee273f5672efdd' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.480 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@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:28:13.480 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 out <iq type='set' id='10a5aab41617b18b1f1b13a5326d7a7d'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-25 16:28:13.481 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 in <iq id='10a5aab41617b18b1f1b13a5326d7a7d' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1</jid> </bind> </iq>
*** User 2022-01-25 16:28:13.481 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 out <iq type='set' id='16deca6b83d0f96d218f9915e7f66b45'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:28:13.481 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 in <iq type='result' id='16deca6b83d0f96d218f9915e7f66b45'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:28:13.481 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 out <presence/>
*** User 2022-01-25 16:28:13.483 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 in <presence from='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1' xml:lang='en'/>
*** User 2022-01-25 16:28:13.486 *** eve_unnamed_1620@localhost 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:28:13.486 *** eve_unnamed_1620@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='e1f7a8e37e7a3f8e' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.486 *** eve_unnamed_1620@localhost in <stream:features> <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> <register xmlns='http://jabber.org/features/iq-register'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2022-01-25 16:28:13.486 *** eve_unnamed_1620@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzE2MjAAcGFzc3dvcmQ=</auth>
*** User 2022-01-25 16:28:13.490 *** eve_unnamed_1620@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:28:13.490 *** eve_unnamed_1620@localhost 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:28:13.490 *** eve_unnamed_1620@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='1f805a38a5b9a63a' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.490 *** eve_unnamed_1620@localhost in <stream:features> <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'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2022-01-25 16:28:13.490 *** eve_unnamed_1620@localhost out <iq type='set' id='f5e8b0139097be83edd7799d499bbde8'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2022-01-25 16:28:13.491 *** eve_unnamed_1620@localhost in <iq id='f5e8b0139097be83edd7799d499bbde8' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_1620@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2022-01-25 16:28:13.491 *** eve_unnamed_1620@localhost/escalus-default-resource out <iq type='set' id='3ecc2d9cda3a6d6366ae5a69491e0dbf'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:28:13.491 *** eve_unnamed_1620@localhost/escalus-default-resource in <iq type='result' id='3ecc2d9cda3a6d6366ae5a69491e0dbf'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:28:13.491 *** eve_unnamed_1620@localhost/escalus-default-resource out <enable xmlns='urn:xmpp:sm:3' resume='true'/>
*** User 2022-01-25 16:28:13.492 *** eve_unnamed_1620@localhost/escalus-default-resource in <enabled xmlns='urn:xmpp:sm:3' id='Glk0GY01ZhyJ/oDaaVA7t8ZAQpSp' resume='true'/>
*** User 2022-01-25 16:28:13.492 *** eve_unnamed_1620@localhost/escalus-default-resource out <presence/>
*** User 2022-01-25 16:28:13.493 *** eve_unnamed_1620@localhost/escalus-default-resource in <presence from='eve_unnamed_1620@localhost/escalus-default-resource' to='eve_unnamed_1620@localhost/escalus-default-resource' xml:lang='en'/>
*** User 2022-01-25 16:28:13.494 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 out <message to='eve_unnamed_1620@localhost' type='chat' id='-576460363373335266'> <body>Hi from Europe1!</body> </message>
*** User 2022-01-25 16:28:13.596 *** eve_unnamed_1620@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:28:13.596 *** eve_unnamed_1620@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='733c88b95c469fda' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.596 *** eve_unnamed_1620@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:28:13.597 *** eve_unnamed_1620@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzE2MjAAcGFzc3dvcmQ=</auth>
*** User 2022-01-25 16:28:13.602 *** eve_unnamed_1620@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:28:13.602 *** eve_unnamed_1620@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:28:13.605 *** eve_unnamed_1620@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='714d1c3f8d38567a' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.605 *** eve_unnamed_1620@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:28:13.605 *** eve_unnamed_1620@localhost/res1 out <iq type='set' id='3cd74502acd11195b05abaa907ca7f5d'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-25 16:28:13.605 *** eve_unnamed_1620@localhost/res1 in <iq id='3cd74502acd11195b05abaa907ca7f5d' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_1620@localhost/res1</jid> </bind> </iq>
*** User 2022-01-25 16:28:13.605 *** eve_unnamed_1620@localhost/res1 out <iq type='set' id='93a418ffb888268b88130592afb5abe6'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:28:13.605 *** eve_unnamed_1620@localhost/res1 in <iq type='result' id='93a418ffb888268b88130592afb5abe6'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:28:13.606 *** eve_unnamed_1620@localhost/res1 out <presence/>
*** User 2022-01-25 16:28:13.616 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 out <message to='eve_unnamed_1620@localhost' type='chat' id='-576460363251027045'> <body>Hi again from Europe1!</body> </message>
*** User 2022-01-25 16:28:13.616 *** eve_unnamed_1620@localhost/res1 out <message to='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1' type='chat'> <body>Hi from Europe!</body> </message>
*** User 2022-01-25 16:28:13.618 *** eve_unnamed_1620@localhost/res1 in <message from='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1' to='eve_unnamed_1620@localhost' xml:lang='en' type='chat' id='-576460363373335266'> <body>Hi from Europe1!</body> <delay xmlns='urn:xmpp:delay' stamp='2022-01-25T16:28:13.614098Z' from='localhost'>SM Storage</delay> </message>
*** User 2022-01-25 16:28:13.618 *** eve_unnamed_1620@localhost/res1 in <message from='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1' to='eve_unnamed_1620@localhost' xml:lang='en' type='chat' id='-576460363251027045'> <body>Hi again from Europe1!</body> </message>
*** User 2022-01-25 16:28:13.618 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 in <message from='eve_unnamed_1620@localhost/res1' to='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1' xml:lang='en' type='chat'> <body>Hi from Europe!</body> </message>
*** User 2022-01-25 16:28:13.618 *** eve_unnamed_1620@localhost/res1 out </stream:stream>
*** User 2022-01-25 16:28:13.619 *** eve_unnamed_1620@localhost/res1 in </stream:stream>
*** User 2022-01-25 16:28:13.619 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 out </stream:stream>
*** User 2022-01-25 16:28:13.622 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/res1 in </stream:stream>
*** User 2022-01-25 16:28:13.626 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost 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:28:13.626 *** eve_unnamed_1620@localhost 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:28:13.627 *** eve_unnamed_1620@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='273b968c8a12c849' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.627 *** eve_unnamed_1620@localhost in <stream:features> <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> <register xmlns='http://jabber.org/features/iq-register'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2022-01-25 16:28:13.627 *** eve_unnamed_1620@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzE2MjAAcGFzc3dvcmQ=</auth>
*** User 2022-01-25 16:28:13.628 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='ee9ada0320e2412d' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.628 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost 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:28:13.628 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3Rlc3RfcG1fd2l0aF91bmdyYWNlZnVsX3JlY29ubmVjdGlvbl90b19kaWZmZXJlbnRfc2VydmVyX3dpdGhfYXNpYV9yZWZyZXNoZXNfZmlyc3RfMTYyMQBtYXR5Z3J5c2E=</auth>
*** User 2022-01-25 16:28:13.634 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:28:13.634 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost 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:28:13.634 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='f3c9d522e0fc43d9' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.636 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost 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:28:13.637 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost out <iq type='set' id='80ea72feff3c13d6441f3f62b5c65097'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2022-01-25 16:28:13.637 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost in <iq id='80ea72feff3c13d6441f3f62b5c65097' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2022-01-25 16:28:13.639 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/escalus-default-resource out <iq type='set' id='b0f9d2b28ecfbf9a6b4f0a6825190977'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:28:13.640 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/escalus-default-resource in <iq type='result' id='b0f9d2b28ecfbf9a6b4f0a6825190977'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:28:13.640 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/escalus-default-resource out <iq type='set' id='ca8746158fa00c641f28317bc617cb86'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2022-01-25 16:28:13.641 *** eve_unnamed_1620@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-25 16:28:13.641 *** eve_unnamed_1620@localhost 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:28:13.643 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/escalus-default-resource in <iq from='' to='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/escalus-default-resource' id='ca8746158fa00c641f28317bc617cb86' type='result'/>
*** User 2022-01-25 16:28:13.643 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/escalus-default-resource out </stream:stream>
*** User 2022-01-25 16:28:13.643 *** eve_unnamed_1620@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='6d1a46388651d27f' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.643 *** eve_unnamed_1620@localhost in <stream:features> <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'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2022-01-25 16:28:13.643 *** eve_unnamed_1620@localhost out <iq type='set' id='b34822c168d869c4832d999ca82c4535'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2022-01-25 16:28:13.644 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_1621@localhost/escalus-default-resource in </stream:stream>
*** User 2022-01-25 16:28:13.644 *** eve_unnamed_1620@localhost in <iq id='b34822c168d869c4832d999ca82c4535' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_1620@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2022-01-25 16:28:13.644 *** eve_unnamed_1620@localhost/escalus-default-resource out <iq type='set' id='7f1e7aadbd66c9bc1b9920181347488b'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:28:13.645 *** eve_unnamed_1620@localhost/escalus-default-resource in <iq type='result' id='7f1e7aadbd66c9bc1b9920181347488b'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-25 16:28:13.645 *** eve_unnamed_1620@localhost/escalus-default-resource out <iq type='set' id='5d4b23b3da8d8948925bcdb2421265de'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2022-01-25 16:28:13.650 *** eve_unnamed_1620@localhost/escalus-default-resource in <iq from='' to='eve_unnamed_1620@localhost/escalus-default-resource' id='5d4b23b3da8d8948925bcdb2421265de' type='result'/>
*** User 2022-01-25 16:28:13.650 *** eve_unnamed_1620@localhost/escalus-default-resource out </stream:stream>
*** User 2022-01-25 16:28:13.650 *** eve_unnamed_1620@localhost/escalus-default-resource in </stream:stream>
*** User 2022-01-25 16:28:13.659 *** eve_unnamed_1620@localhost 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:28:13.659 *** eve_unnamed_1620@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='f9ba3c419aff5d56' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-25 16:28:13.659 *** eve_unnamed_1620@localhost 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:28:13.659 *** eve_unnamed_1620@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzE2MjAAcGFzc3dvcmQ=</auth>
*** User 2022-01-25 16:28:13.661 *** eve_unnamed_1620@localhost in <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'> <not-authorized/> </failure>
=== Ended at 2022-01-25 16:28:13 === successfully completed test case === === Returned value: ok
Test run history | Top level test index | Latest test result