=== 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.20927.0>}, {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,"ldap_mnesia"}, {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@d66972e2ee88.2022-01-27_15.24.27/big_tests.tests.mod_global_distrib_SUITE.logs/run.2022-01-27_15.27.41/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@d66972e2ee88.2022-01-27_15.24.27/big_tests.tests.mod_global_distrib_SUITE.logs/run.2022-01-27_15.27.41/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 => [],mod_sic => [],mod_stream_management => [], mod_vcard => [{backend,ldap}, {host,{prefix,<<"vjud.">>}}, {ldap_base,"ou=Users,dc=esl,dc=com"}, {ldap_filter,<<"(objectClass=inetOrgPerson)">>}]}}, {{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_last => [],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 => [],mod_sic => [],mod_stream_management => [], mod_vcard => [{backend,ldap}, {host,{prefix,<<"vjud.">>}}, {ldap_base,"ou=Users,dc=esl,dc=com"}, {ldap_filter,<<"(objectClass=inetOrgPerson)">>}]}}, {{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 => [],mod_sic => [],mod_stream_management => [], mod_vcard => [{backend,ldap}, {host,{prefix,<<"vjud.">>}}, {ldap_base,"ou=Users,dc=esl,dc=com"}, {ldap_filter,<<"(objectClass=inetOrgPerson)">>}]}}, {{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 => [],mod_sic => [],mod_stream_management => [], mod_vcard => [{backend,ldap}, {host,{prefix,<<"vjud.">>}}, {ldap_base,"ou=Users,dc=esl,dc=com"}, {ldap_filter,<<"(objectClass=inetOrgPerson)">>}]}}, {{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 => [],mod_sic => [],mod_stream_management => [], mod_vcard => [{backend,ldap}, {host,{prefix,<<"vjud.">>}}, {ldap_base,"ou=Users,dc=esl,dc=com"}, {ldap_filter,<<"(objectClass=inetOrgPerson)">>}]}}] === Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@d66972e2ee88.2022-01-27_15.24.27" === Started at 2022-01-27 15:27:50
*** User 2022-01-27 15:27:50.299 *** eve_unnamed_608@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-27 15:27:50.300 *** eve_unnamed_608@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='706c7c8f4a70595a' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.300 *** eve_unnamed_608@localhost in <stream:features> <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/> <mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'> <mechanism>PLAIN</mechanism> </mechanisms> <register xmlns='http://jabber.org/features/iq-register'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2022-01-27 15:27:50.300 *** eve_unnamed_608@localhost out <iq type='get' id='0219402d234eb13c94ef17dc72f7f4ed'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:27:50.300 *** eve_unnamed_608@localhost in <iq from='localhost' id='0219402d234eb13c94ef17dc72f7f4ed' 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-27 15:27:50.300 *** eve_unnamed_608@localhost out <iq type='set' id='ec5f8e297088f564decc4be2ddc7a135'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_608</username> <password>password</password> </query> </iq>
*** User 2022-01-27 15:27:50.302 *** eve_unnamed_608@localhost in <iq from='localhost' id='ec5f8e297088f564decc4be2ddc7a135' type='result'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_608</username> <password>password</password> </query> </iq>
*** User 2022-01-27 15:27:50.302 *** eve_unnamed_608@localhost out </stream:stream>
*** User 2022-01-27 15:27:50.302 *** eve_unnamed_608@localhost in </stream:stream>
*** User 2022-01-27 15:27:50.303 *** eve_unnamed_608@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-27 15:27:50.304 *** eve_unnamed_608@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='b63a28c0638fe7bd' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.304 *** eve_unnamed_608@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>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-27 15:27:50.304 *** eve_unnamed_608@localhost out <iq type='get' id='4a42befa609f0fd4a12470d62fa949fb'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:27:50.304 *** eve_unnamed_608@localhost in <iq from='localhost' id='4a42befa609f0fd4a12470d62fa949fb' 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-27 15:27:50.304 *** eve_unnamed_608@localhost out <iq type='set' id='173f0c27ca7e5ef6dc6f28c997698265'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_608</username> <password>password</password> </query> </iq>
*** User 2022-01-27 15:27:50.305 *** eve_unnamed_608@localhost in <iq from='localhost' id='173f0c27ca7e5ef6dc6f28c997698265' type='error'> <query xmlns='jabber:iq:register'> <username>eve_unnamed_608</username> <password>password</password> </query> <error code='409' type='cancel'> <conflict xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/> </error> </iq>
*** User 2022-01-27 15:27:50.305 *** eve_unnamed_608@localhost out </stream:stream>
*** User 2022-01-27 15:27:50.305 *** eve_unnamed_608@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-27 15:27:50.305 *** =INFO REPORT==== 27-Jan-2022::15:27:50.305605 === user already existed:eve_unnamed_608 password
*** User 2022-01-27 15:27:50.307 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@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-27 15:27:50.307 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='1675b33249f647c7' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.307 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@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>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-27 15:27:50.308 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost out <iq type='get' id='07894c4d89892be252b29cdbaa311c95'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:27:50.308 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost in <iq from='localhost' id='07894c4d89892be252b29cdbaa311c95' 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-27 15:27:50.308 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost out <iq type='set' id='86089c963fa95ac8280ea5a203fdca82'> <query xmlns='jabber:iq:register'> <username>alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:27:50.309 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost in <iq from='localhost' id='86089c963fa95ac8280ea5a203fdca82' type='result'> <query xmlns='jabber:iq:register'> <username>alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:27:50.309 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost out </stream:stream>
*** User 2022-01-27 15:27:50.309 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost in </stream:stream>
*** User 2022-01-27 15:27:50.310 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@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-27 15:27:50.310 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='88043b2beca26b24' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.310 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@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>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-27 15:27:50.310 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3Rlc3RfcG1fd2l0aF91bmdyYWNlZnVsX3JlY29ubmVjdGlvbl90b19kaWZmZXJlbnRfc2VydmVyX3dpdGhfYXNpYV9yZWZyZXNoZXNfZmlyc3RfNjA5AG1hdHlncnlzYQ==</auth>
*** User 2022-01-27 15:27:50.311 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:27:50.311 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@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-27 15:27:50.312 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a3e943837adf6954' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.312 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@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-27 15:27:50.312 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 out <iq type='set' id='aaa9e5115c65482f996e9053818be197'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-27 15:27:50.312 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 in <iq id='aaa9e5115c65482f996e9053818be197' 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_609@localhost/res1</jid> </bind> </iq>
*** User 2022-01-27 15:27:50.312 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 out <iq type='set' id='019c4587877beae4096d5c618c4a9846'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:27:50.312 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 in <iq type='result' id='019c4587877beae4096d5c618c4a9846'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:27:50.312 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 out <presence/>
*** User 2022-01-27 15:27:50.314 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 in <presence from='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1' to='alice_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1' xml:lang='en'/>
*** User 2022-01-27 15:27:50.314 *** eve_unnamed_608@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-27 15:27:50.315 *** eve_unnamed_608@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='e63afee19d88d8b7' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.315 *** eve_unnamed_608@localhost in <stream:features> <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/> <mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'> <mechanism>PLAIN</mechanism> </mechanisms> <register xmlns='http://jabber.org/features/iq-register'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2022-01-27 15:27:50.315 *** eve_unnamed_608@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzYwOABwYXNzd29yZA==</auth>
*** User 2022-01-27 15:27:50.316 *** eve_unnamed_608@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:27:50.316 *** eve_unnamed_608@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-27 15:27:50.316 *** eve_unnamed_608@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a9433e7fded7042b' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.316 *** eve_unnamed_608@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-27 15:27:50.316 *** eve_unnamed_608@localhost out <iq type='set' id='19188f47b879884cf9ce9dd5f4cf1a28'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2022-01-27 15:27:50.317 *** eve_unnamed_608@localhost in <iq id='19188f47b879884cf9ce9dd5f4cf1a28' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_608@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2022-01-27 15:27:50.317 *** eve_unnamed_608@localhost/escalus-default-resource out <iq type='set' id='07a514854dc8b03629eaac963be48c02'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:27:50.317 *** eve_unnamed_608@localhost/escalus-default-resource in <iq type='result' id='07a514854dc8b03629eaac963be48c02'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:27:50.317 *** eve_unnamed_608@localhost/escalus-default-resource out <enable xmlns='urn:xmpp:sm:3' resume='true'/>
*** User 2022-01-27 15:27:50.318 *** eve_unnamed_608@localhost/escalus-default-resource in <enabled xmlns='urn:xmpp:sm:3' id='LSYj9Y3oGNXTthSu8XJDN7vevJeR' resume='true'/>
*** User 2022-01-27 15:27:50.318 *** eve_unnamed_608@localhost/escalus-default-resource out <presence/>
*** User 2022-01-27 15:27:50.319 *** eve_unnamed_608@localhost/escalus-default-resource in <presence from='eve_unnamed_608@localhost/escalus-default-resource' to='eve_unnamed_608@localhost/escalus-default-resource' xml:lang='en'/>
*** User 2022-01-27 15:27:50.320 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 out <message to='eve_unnamed_608@localhost' type='chat' id='-576460528075428736'> <body>Hi from Europe1!</body> </message>
*** User 2022-01-27 15:27:50.421 *** eve_unnamed_608@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-27 15:27:50.422 *** eve_unnamed_608@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='b4c9b28ad9c34437' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.422 *** eve_unnamed_608@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>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-27 15:27:50.422 *** eve_unnamed_608@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzYwOABwYXNzd29yZA==</auth>
*** User 2022-01-27 15:27:50.424 *** eve_unnamed_608@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:27:50.424 *** eve_unnamed_608@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-27 15:27:50.424 *** eve_unnamed_608@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='68f0dd8acde136c7' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.424 *** eve_unnamed_608@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-27 15:27:50.424 *** eve_unnamed_608@localhost/res1 out <iq type='set' id='4df340ccc13b016715fdba8ff61d8d7c'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-27 15:27:50.424 *** eve_unnamed_608@localhost/res1 in <iq id='4df340ccc13b016715fdba8ff61d8d7c' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_608@localhost/res1</jid> </bind> </iq>
*** User 2022-01-27 15:27:50.425 *** eve_unnamed_608@localhost/res1 out <iq type='set' id='9f8c4603ede46085d628478ed05b064a'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:27:50.425 *** eve_unnamed_608@localhost/res1 in <iq type='result' id='9f8c4603ede46085d628478ed05b064a'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:27:50.425 *** eve_unnamed_608@localhost/res1 out <presence/>
*** User 2022-01-27 15:27:50.436 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 out <message to='eve_unnamed_608@localhost' type='chat' id='-576460527959228160'> <body>Hi again from Europe1!</body> </message>
*** User 2022-01-27 15:27:50.436 *** eve_unnamed_608@localhost/res1 out <message to='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1' type='chat'> <body>Hi from Europe!</body> </message>
*** User 2022-01-27 15:27:50.437 *** eve_unnamed_608@localhost/res1 in <message from='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1' to='eve_unnamed_608@localhost' xml:lang='en' type='chat' id='-576460527959228160'> <body>Hi again from Europe1!</body> </message>
*** User 2022-01-27 15:27:50.439 *** eve_unnamed_608@localhost/res1 in <message from='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1' to='eve_unnamed_608@localhost' xml:lang='en' type='chat' id='-576460528075428736'> <body>Hi from Europe1!</body> <delay xmlns='urn:xmpp:delay' stamp='2022-01-27T15:27:50.431518Z' from='localhost'>SM Storage</delay> </message>
*** User 2022-01-27 15:27:50.440 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 in <message from='eve_unnamed_608@localhost/res1' to='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1' xml:lang='en' type='chat'> <body>Hi from Europe!</body> </message>
*** User 2022-01-27 15:27:50.440 *** eve_unnamed_608@localhost/res1 out </stream:stream>
*** User 2022-01-27 15:27:50.440 *** eve_unnamed_608@localhost/res1 in </stream:stream>
*** User 2022-01-27 15:27:50.440 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 out </stream:stream>
*** User 2022-01-27 15:27:50.440 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/res1 in </stream:stream>
*** User 2022-01-27 15:27:50.443 *** eve_unnamed_608@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-27 15:27:50.443 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@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-27 15:27:50.443 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3fa33e284d9d1382' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.443 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@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>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-27 15:27:50.443 *** eve_unnamed_608@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='37f2345b990cd868' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.443 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX3Rlc3RfcG1fd2l0aF91bmdyYWNlZnVsX3JlY29ubmVjdGlvbl90b19kaWZmZXJlbnRfc2VydmVyX3dpdGhfYXNpYV9yZWZyZXNoZXNfZmlyc3RfNjA5AG1hdHlncnlzYQ==</auth>
*** User 2022-01-27 15:27:50.443 *** eve_unnamed_608@localhost in <stream:features> <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/> <mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'> <mechanism>PLAIN</mechanism> </mechanisms> <register xmlns='http://jabber.org/features/iq-register'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2022-01-27 15:27:50.443 *** eve_unnamed_608@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzYwOABwYXNzd29yZA==</auth>
*** User 2022-01-27 15:27:50.444 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:27:50.445 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@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-27 15:27:50.445 *** eve_unnamed_608@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:27:50.445 *** eve_unnamed_608@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-27 15:27:50.445 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='aafd43ede1a78473' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.445 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@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-27 15:27:50.445 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost out <iq type='set' id='69f4537380912cb28734ad86e5ac6c04'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2022-01-27 15:27:50.445 *** eve_unnamed_608@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='86d1fa5bb24b0b09' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.445 *** eve_unnamed_608@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-27 15:27:50.445 *** eve_unnamed_608@localhost out <iq type='set' id='5cd59961068648453d7ebf5cf10990e7'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2022-01-27 15:27:50.445 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost in <iq id='69f4537380912cb28734ad86e5ac6c04' 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_609@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2022-01-27 15:27:50.446 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/escalus-default-resource out <iq type='set' id='b6080d51ed019ed829cc399b91b575ca'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:27:50.446 *** eve_unnamed_608@localhost in <iq id='5cd59961068648453d7ebf5cf10990e7' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>eve_unnamed_608@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2022-01-27 15:27:50.446 *** eve_unnamed_608@localhost/escalus-default-resource out <iq type='set' id='736cb03167622aabdc92ab776c455fc5'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:27:50.446 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/escalus-default-resource in <iq type='result' id='b6080d51ed019ed829cc399b91b575ca'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:27:50.446 *** eve_unnamed_608@localhost/escalus-default-resource in <iq type='result' id='736cb03167622aabdc92ab776c455fc5'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:27:50.446 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/escalus-default-resource out <iq type='set' id='8e02ff13fbf16539efda096aed3ae41b'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2022-01-27 15:27:50.446 *** eve_unnamed_608@localhost/escalus-default-resource out <iq type='set' id='3ef344dd27cbb01c3e251021a116a3b9'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2022-01-27 15:27:50.448 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/escalus-default-resource in <iq from='' to='alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/escalus-default-resource' id='8e02ff13fbf16539efda096aed3ae41b' type='result'/>
*** User 2022-01-27 15:27:50.448 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/escalus-default-resource out </stream:stream>
*** User 2022-01-27 15:27:50.448 *** eve_unnamed_608@localhost/escalus-default-resource in <iq from='' to='eve_unnamed_608@localhost/escalus-default-resource' id='3ef344dd27cbb01c3e251021a116a3b9' type='result'/>
*** User 2022-01-27 15:27:50.448 *** eve_unnamed_608@localhost/escalus-default-resource out </stream:stream>
*** User 2022-01-27 15:27:50.448 *** alicE_test_pm_with_ungraceful_reconnection_to_different_server_with_asia_refreshes_first_609@localhost/escalus-default-resource in </stream:stream>
*** User 2022-01-27 15:27:50.448 *** eve_unnamed_608@localhost/escalus-default-resource in </stream:stream>
*** User 2022-01-27 15:27:50.450 *** eve_unnamed_608@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-27 15:27:50.450 *** eve_unnamed_608@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='988863f06472c5c6' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:27:50.450 *** eve_unnamed_608@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>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-27 15:27:50.450 *** eve_unnamed_608@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGV2ZV91bm5hbWVkXzYwOABwYXNzd29yZA==</auth>
*** User 2022-01-27 15:27:50.451 *** eve_unnamed_608@localhost in <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'> <not-authorized/> </failure>
=== Ended at 2022-01-27 15:27:50 === successfully completed test case === === Returned value: ok
Test run history | Top level test index | Latest test result