=== Test case: accounts_SUITE:registration_timeout/1 (click for source code)

=== Config value:

    [{watchdog,<0.1595.0>},
     {escalus_user_db,xmpp},
     {mod_register_options,
         [{welcome_message,{[],[]}},
          {ip_access,[{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]},
          {access,register},
          {registration_watchers,[]}]},
     {mim_data_dir,
         "/home/circleci/project/big_tests/tests/accounts_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.accounts_SUITE.logs/run.2022-01-25_16.22.03/accounts_suite.registration_timeout.html"},
     {tc_group_properties,[{name,registration_timeout},sequence]},
     {tc_group_path,[]},
     {data_dir,
         "/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/accounts_SUITE_data/"},
     {priv_dir,
         "/home/circleci/project/big_tests/ct_report/ct_run.test@ebe8a8f9fc53.2022-01-25_16.21.59/big_tests.tests.accounts_SUITE.logs/run.2022-01-25_16.22.03/log_private/"},
     {config_backup,#{registration_timeout => {ok,infinity}}}]

=== 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:22:03


*** CT 2022-01-25 16:22:03.863 *** View log from node mongooseim@localhost when started mongooseim@localhost_36.html
*** CT 2022-01-25 16:22:03.864 *** View log from node ejabberd2@localhost when started ejabberd2@localhost_27.html

*** User 2022-01-25 16:22:03.864 ***
alicE@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:22:03.865 ***
alicE@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='50a89b9a80fad836' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:03.865 ***
alicE@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:22:03.865 ***
alicE@localhost out
<iq type='get' id='bac240d323418c295494ab1866eb33dc'>
	<query xmlns='jabber:iq:register'/>
</iq>



*** User 2022-01-25 16:22:03.865 ***
alicE@localhost in
<iq from='localhost' id='bac240d323418c295494ab1866eb33dc' 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:22:03.866 ***
alicE@localhost out
<iq type='set' id='a84958117b7ac90d87f3c97d56c4dcdf'>
	<query xmlns='jabber:iq:register'>
		<username>alicE</username>
		<password>matygrysa</password>
	</query>
</iq>



*** User 2022-01-25 16:22:03.871 ***
alicE@localhost in
<iq from='localhost' id='a84958117b7ac90d87f3c97d56c4dcdf' type='result'>
	<query xmlns='jabber:iq:register'>
		<username>alicE</username>
		<password>matygrysa</password>
	</query>
</iq>



*** User 2022-01-25 16:22:03.871 ***
alicE@localhost out
</stream:stream>

*** User 2022-01-25 16:22:03.871 ***
alicE@localhost in
</stream:stream>

*** User 2022-01-25 16:22:03.872 ***
bOb@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:22:03.872 ***
bOb@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='375c8c17d1a23037' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:03.872 ***
bOb@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:22:03.872 ***
bOb@localhost out
<iq type='get' id='0fc601f5952c6459b85469823876944c'>
	<query xmlns='jabber:iq:register'/>
</iq>



*** User 2022-01-25 16:22:03.872 ***
bOb@localhost in
<iq from='localhost' id='0fc601f5952c6459b85469823876944c' 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:22:03.872 ***
bOb@localhost out
<iq type='set' id='78d4d0657e88c372bdc60b08aaa12e1f'>
	<query xmlns='jabber:iq:register'>
		<username>bOb</username>
		<password>makrolika</password>
	</query>
</iq>



*** User 2022-01-25 16:22:03.873 ***
bOb@localhost in
<iq from='localhost' id='78d4d0657e88c372bdc60b08aaa12e1f' type='error'>
	<error code='500' type='wait'>
		<resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/>
		<text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text>
	</error>
</iq>



*** User 2022-01-25 16:22:03.873 ***
bOb@localhost out
</stream:stream>

*** User 2022-01-25 16:22:03.873 ***
bOb@localhost in
</stream:stream>

*** User 2022-01-25 16:22:03.873 ***
alicE@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:22:03.874 ***
alicE@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a8138aaddbb9aa4e' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:03.874 ***
alicE@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:22:03.874 ***
alicE@localhost out
<iq type='get' id='589c5c34726c8d9bee28fb217ea438fb'>
	<query xmlns='jabber:iq:register'/>
</iq>



*** User 2022-01-25 16:22:03.874 ***
alicE@localhost in
<iq from='localhost' id='589c5c34726c8d9bee28fb217ea438fb' 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:22:03.874 ***
alicE@localhost out
<iq type='set' id='f1926e69179079db4c8b6003b8b0482e'>
	<query xmlns='jabber:iq:register'>
		<username>alicE</username>
		<password>matygrysa</password>
	</query>
</iq>



*** User 2022-01-25 16:22:03.875 ***
alicE@localhost in
<iq from='localhost' id='f1926e69179079db4c8b6003b8b0482e' type='error'>
	<error code='500' type='wait'>
		<resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/>
		<text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text>
	</error>
</iq>



*** User 2022-01-25 16:22:03.875 ***
alicE@localhost out
</stream:stream>

*** User 2022-01-25 16:22:03.875 ***
alicE@localhost in
</stream:stream>

*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-25 16:22:03.875 ***
=ERROR REPORT==== 25-Jan-2022::16:22:03.875507 ===
error when trying to register user: <iq from='localhost' id='f1926e69179079db4c8b6003b8b0482e' type='error'><error code='500' type='wait'><resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/><text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text></error></iq>



*** User 2022-01-25 16:22:04.277 ***
alicE@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:22:04.278 ***
alicE@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='b821b663ba8369c8' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:04.278 ***
alicE@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:22:04.278 ***
alicE@localhost out
<iq type='get' id='146f549701f94bc892a817144803fcff'>
	<query xmlns='jabber:iq:register'/>
</iq>



*** User 2022-01-25 16:22:04.278 ***
alicE@localhost in
<iq from='localhost' id='146f549701f94bc892a817144803fcff' 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:22:04.278 ***
alicE@localhost out
<iq type='set' id='b2092119a5aebc037329f75b3a31bb9d'>
	<query xmlns='jabber:iq:register'>
		<username>alicE</username>
		<password>matygrysa</password>
	</query>
</iq>



*** User 2022-01-25 16:22:04.279 ***
alicE@localhost in
<iq from='localhost' id='b2092119a5aebc037329f75b3a31bb9d' type='error'>
	<error code='500' type='wait'>
		<resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/>
		<text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text>
	</error>
</iq>



*** User 2022-01-25 16:22:04.279 ***
alicE@localhost out
</stream:stream>

*** User 2022-01-25 16:22:04.279 ***
alicE@localhost in
</stream:stream>

*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-25 16:22:04.280 ***
=ERROR REPORT==== 25-Jan-2022::16:22:04.279945 ===
error when trying to register user: <iq from='localhost' id='b2092119a5aebc037329f75b3a31bb9d' type='error'><error code='500' type='wait'><resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/><text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text></error></iq>



*** User 2022-01-25 16:22:04.681 ***
alicE@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:22:04.681 ***
alicE@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='c21ea89fcdb541ac' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:04.681 ***
alicE@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:22:04.682 ***
alicE@localhost out
<iq type='get' id='3462adc7feb9addef1cf145326acad5f'>
	<query xmlns='jabber:iq:register'/>
</iq>



*** User 2022-01-25 16:22:04.682 ***
alicE@localhost in
<iq from='localhost' id='3462adc7feb9addef1cf145326acad5f' 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:22:04.682 ***
alicE@localhost out
<iq type='set' id='34540145f525559bbd8f72f6ceeebbbe'>
	<query xmlns='jabber:iq:register'>
		<username>alicE</username>
		<password>matygrysa</password>
	</query>
</iq>



*** User 2022-01-25 16:22:04.682 ***
alicE@localhost in
<iq from='localhost' id='34540145f525559bbd8f72f6ceeebbbe' type='error'>
	<error code='500' type='wait'>
		<resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/>
		<text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text>
	</error>
</iq>



*** User 2022-01-25 16:22:04.682 ***
alicE@localhost out
</stream:stream>

*** User 2022-01-25 16:22:04.683 ***
alicE@localhost in
</stream:stream>

*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-25 16:22:04.683 ***
=ERROR REPORT==== 25-Jan-2022::16:22:04.683217 ===
error when trying to register user: <iq from='localhost' id='34540145f525559bbd8f72f6ceeebbbe' type='error'><error code='500' type='wait'><resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/><text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text></error></iq>



*** User 2022-01-25 16:22:05.084 ***
alicE@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:22:05.084 ***
alicE@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d23f44e45583eabe' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:05.084 ***
alicE@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:22:05.085 ***
alicE@localhost out
<iq type='get' id='c010686e1ca112c938825f48abe8049f'>
	<query xmlns='jabber:iq:register'/>
</iq>



*** User 2022-01-25 16:22:05.085 ***
alicE@localhost in
<iq from='localhost' id='c010686e1ca112c938825f48abe8049f' 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:22:05.085 ***
alicE@localhost out
<iq type='set' id='8efdd2ea188778594769c796e60f5f5d'>
	<query xmlns='jabber:iq:register'>
		<username>alicE</username>
		<password>matygrysa</password>
	</query>
</iq>



*** User 2022-01-25 16:22:05.085 ***
alicE@localhost in
<iq from='localhost' id='8efdd2ea188778594769c796e60f5f5d' type='error'>
	<error code='500' type='wait'>
		<resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/>
		<text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text>
	</error>
</iq>



*** User 2022-01-25 16:22:05.086 ***
alicE@localhost out
</stream:stream>

*** User 2022-01-25 16:22:05.086 ***
alicE@localhost in
</stream:stream>

*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-25 16:22:05.086 ***
=ERROR REPORT==== 25-Jan-2022::16:22:05.086346 ===
error when trying to register user: <iq from='localhost' id='8efdd2ea188778594769c796e60f5f5d' type='error'><error code='500' type='wait'><resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/><text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text></error></iq>



*** User 2022-01-25 16:22:05.488 ***
alicE@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:22:05.488 ***
alicE@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='c7f5557273e3a849' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:05.488 ***
alicE@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:22:05.489 ***
alicE@localhost out
<iq type='get' id='fdffd02ba2c5bf1ce4843e59fd8c9843'>
	<query xmlns='jabber:iq:register'/>
</iq>



*** User 2022-01-25 16:22:05.489 ***
alicE@localhost in
<iq from='localhost' id='fdffd02ba2c5bf1ce4843e59fd8c9843' 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:22:05.489 ***
alicE@localhost out
<iq type='set' id='15ea663c59872ebcc91a32e527ffc1d3'>
	<query xmlns='jabber:iq:register'>
		<username>alicE</username>
		<password>matygrysa</password>
	</query>
</iq>



*** User 2022-01-25 16:22:05.489 ***
alicE@localhost in
<iq from='localhost' id='15ea663c59872ebcc91a32e527ffc1d3' type='error'>
	<error code='500' type='wait'>
		<resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/>
		<text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text>
	</error>
</iq>



*** User 2022-01-25 16:22:05.490 ***
alicE@localhost out
</stream:stream>

*** User 2022-01-25 16:22:05.490 ***
alicE@localhost in
</stream:stream>

*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-25 16:22:05.490 ***
=ERROR REPORT==== 25-Jan-2022::16:22:05.490281 ===
error when trying to register user: <iq from='localhost' id='15ea663c59872ebcc91a32e527ffc1d3' type='error'><error code='500' type='wait'><resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/><text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text></error></iq>



*** User 2022-01-25 16:22:05.891 ***
alicE@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:22:05.891 ***
alicE@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='ea92adafd8d26a6e' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:05.892 ***
alicE@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:22:05.892 ***
alicE@localhost out
<iq type='get' id='e224209518efffae00e404cf52414f27'>
	<query xmlns='jabber:iq:register'/>
</iq>



*** User 2022-01-25 16:22:05.892 ***
alicE@localhost in
<iq from='localhost' id='e224209518efffae00e404cf52414f27' 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:22:05.892 ***
alicE@localhost out
<iq type='set' id='dd82c9a581e1dff0e2a19f009753a5a7'>
	<query xmlns='jabber:iq:register'>
		<username>alicE</username>
		<password>matygrysa</password>
	</query>
</iq>



*** User 2022-01-25 16:22:05.892 ***
alicE@localhost in
<iq from='localhost' id='dd82c9a581e1dff0e2a19f009753a5a7' type='error'>
	<error code='500' type='wait'>
		<resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/>
		<text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text>
	</error>
</iq>



*** User 2022-01-25 16:22:05.892 ***
alicE@localhost out
</stream:stream>

*** User 2022-01-25 16:22:05.893 ***
alicE@localhost in
</stream:stream>

*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-25 16:22:05.893 ***
=ERROR REPORT==== 25-Jan-2022::16:22:05.893217 ===
error when trying to register user: <iq from='localhost' id='dd82c9a581e1dff0e2a19f009753a5a7' type='error'><error code='500' type='wait'><resource-constraint xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/><text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>Users are not allowed to register accounts so quickly</text></error></iq>



*** User 2022-01-25 16:22:06.294 ***
alicE@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:22:06.295 ***
alicE@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='ee0c08dffd0ebe61' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:06.295 ***
alicE@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:22:06.295 ***
alicE@localhost out
<iq type='get' id='c7bfa63fc177590c625262c5925a31ba'>
	<query xmlns='jabber:iq:register'/>
</iq>



*** User 2022-01-25 16:22:06.295 ***
alicE@localhost in
<iq from='localhost' id='c7bfa63fc177590c625262c5925a31ba' 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:22:06.295 ***
alicE@localhost out
<iq type='set' id='1b778755e7c82713222d54b7957521c0'>
	<query xmlns='jabber:iq:register'>
		<username>alicE</username>
		<password>matygrysa</password>
	</query>
</iq>



*** User 2022-01-25 16:22:06.297 ***
alicE@localhost in
<iq from='localhost' id='1b778755e7c82713222d54b7957521c0' type='error'>
	<query xmlns='jabber:iq:register'>
		<username>alicE</username>
		<password>matygrysa</password>
	</query>
	<error code='409' type='cancel'>
		<conflict xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/>
	</error>
</iq>



*** User 2022-01-25 16:22:06.297 ***
alicE@localhost out
</stream:stream>

*** User 2022-01-25 16:22:06.297 ***
alicE@localhost in
</stream:stream>

*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-25 16:22:06.297 ***
=INFO REPORT==== 25-Jan-2022::16:22:06.297557 ===
user already existed: <iq from='localhost' id='1b778755e7c82713222d54b7957521c0' type='error'><query xmlns='jabber:iq:register'><username>alicE</username><password>matygrysa</password></query><error code='409' type='cancel'><conflict xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq>



*** User 2022-01-25 16:22:06.300 ***
alicE@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:22:06.300 ***
alicE@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='edee2f53b96e3a73' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:06.300 ***
alicE@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:22:06.300 ***
alicE@localhost out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFAG1hdHlncnlzYQ==</auth>



*** User 2022-01-25 16:22:06.302 ***
alicE@localhost in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2022-01-25 16:22:06.302 ***
alicE@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:22:06.302 ***
alicE@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='300473bab75ccbf9' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:06.302 ***
alicE@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:22:06.302 ***
alicE@localhost out
<iq type='set' id='91268df376b77ffbf5141c44a281e42c'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>escalus-default-resource</resource>
	</bind>
</iq>



*** User 2022-01-25 16:22:06.302 ***
alicE@localhost in
<iq id='91268df376b77ffbf5141c44a281e42c' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>alicE@localhost/escalus-default-resource</jid>
	</bind>
</iq>



*** User 2022-01-25 16:22:06.302 ***
alicE@localhost/escalus-default-resource out
<iq type='set' id='353284238dcd808d225c4faf0d6c71c9'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-01-25 16:22:06.303 ***
alicE@localhost/escalus-default-resource in
<iq type='result' id='353284238dcd808d225c4faf0d6c71c9'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2022-01-25 16:22:06.303 ***
alicE@localhost/escalus-default-resource out
<iq type='set' id='25fbce7ae3edd5b83ca428ab15258889'>
	<query xmlns='jabber:iq:register'>
		<remove/>
	</query>
</iq>



*** User 2022-01-25 16:22:06.304 ***
alicE@localhost/escalus-default-resource in
<iq from='' to='alicE@localhost/escalus-default-resource' id='25fbce7ae3edd5b83ca428ab15258889' type='result'/>



*** User 2022-01-25 16:22:06.304 ***
alicE@localhost/escalus-default-resource out
</stream:stream>

*** User 2022-01-25 16:22:06.304 ***
alicE@localhost/escalus-default-resource in
</stream:stream>

*** User 2022-01-25 16:22:06.305 ***
bOb@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:22:06.305 ***
bOb@localhost in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a8c8ad251e6bc761' from='localhost' version='1.0' xml:lang='en'>

*** User 2022-01-25 16:22:06.305 ***
bOb@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:22:06.306 ***
bOb@localhost out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYgBtYWtyb2xpa2E=</auth>



*** User 2022-01-25 16:22:06.307 ***
bOb@localhost in
<failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
	<not-authorized/>
</failure>


=== WARNING: end_per_testcase crashed!
Reason: {badmatch,
    {error,
        {connection_step_failed,
            {{escalus_session,authenticate},
             {client,<<"bOb@localhost">>,escalus_tcp,<0.1623.0>,undefined,
                 [{username,<<"bOb">>},
                  {server,<<"localhost">>},
                  {host,<<"localhost">>},
                  {port,5222},
                  {auth,{escalus_auth,auth_plain}},
                  {wspath,undefined},
                  {username,<<"bOb">>},
                  {server,<<"localhost">>},
                  {password,<<"makrolika">>},
                  {stream_id,<<"a8c8ad251e6bc761">>}]},
             [{compression,[<<"zlib">>]},
              {starttls,true},
              {stream_management,true},
              {advanced_message_processing,true},
              {client_state_indication,false},
              {sasl_mechanisms,[<<"SCRAM-SHA-256">>,<<"PLAIN">>]},
              {caps,undefined}]},
            {auth_failed,<<"bOb">>,
                {xmlel,<<"failure">>,
                    [{<<"xmlns">>,<<"urn:ietf:params:xml:ns:xmpp-sasl">>}],
                    [{xmlel,<<"not-authorized">>,[],[]}]}}}}}
Line: [{escalus_users,delete_user,297},
              {escalus_users,'-delete_users/2-lc$^0/1-0-',110},
              {escalus_users,'-delete_users/2-lc$^0/1-0-',110},
              {accounts_SUITE,end_per_testcase,173},
              {test_server,do_end_per_testcase,1627},
              {test_server,run_test_case_eval1,1335},
              {test_server,run_test_case_eval,1224}]

*** CT 2022-01-25 16:22:06.309 *** View log from node ejabberd2@localhost when finished ejabberd2@localhost_27.html
*** CT 2022-01-25 16:22:06.309 *** View log from node mongooseim@localhost when finished mongooseim@localhost_36.html



=== Ended at 2022-01-25 16:22:06
=== successfully completed test case
=== === Returned value: {ok,ok}


Test run history | Top level test index | Latest test result