=== Test case: accounts_SUITE:registration_timeout/1 (click for source code) === Config value: [{watchdog,<0.1667.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@cb94372a8ea7.2022-04-04_15.02.36/big_tests.tests.accounts_SUITE.logs/run.2022-04-04_15.02.40/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@cb94372a8ea7.2022-04-04_15.02.36/big_tests.tests.accounts_SUITE.logs/run.2022-04-04_15.02.40/log_private/"}, {config_backup,#{registration_timeout => {ok,infinity}}}] === Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@cb94372a8ea7.2022-04-04_15.02.36" === Started at 2022-04-04 15:02:41
*** User 2022-04-04 15:02:41.363 *** 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-04-04 15:02:41.363 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='d861ae427088b227' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:41.364 *** 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-04-04 15:02:41.364 *** alicE@localhost out <iq type='get' id='c372229b2d48b8f0d52dbd23129c9ac4'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-04-04 15:02:41.364 *** alicE@localhost in <iq from='localhost' id='c372229b2d48b8f0d52dbd23129c9ac4' 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-04-04 15:02:41.364 *** alicE@localhost out <iq type='set' id='a63764e4286306667142dcb91521d172'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-04-04 15:02:41.377 *** alicE@localhost in <iq from='localhost' id='a63764e4286306667142dcb91521d172' type='result'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-04-04 15:02:41.377 *** alicE@localhost out </stream:stream>
*** User 2022-04-04 15:02:41.378 *** alicE@localhost in </stream:stream>
*** User 2022-04-04 15:02:41.378 *** 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-04-04 15:02:41.379 *** bOb@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='011afc65c69f148f' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:41.379 *** 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-04-04 15:02:41.379 *** bOb@localhost out <iq type='get' id='9f90fc40f1abb4cd0799397221b5dd44'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-04-04 15:02:41.379 *** bOb@localhost in <iq from='localhost' id='9f90fc40f1abb4cd0799397221b5dd44' 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-04-04 15:02:41.379 *** bOb@localhost out <iq type='set' id='98361e5c4c944587d2112dab086709bc'> <query xmlns='jabber:iq:register'> <username>bOb</username> <password>makrolika</password> </query> </iq>
*** User 2022-04-04 15:02:41.380 *** bOb@localhost in <iq from='localhost' id='98361e5c4c944587d2112dab086709bc' 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-04-04 15:02:41.380 *** bOb@localhost out </stream:stream>
*** User 2022-04-04 15:02:41.380 *** bOb@localhost in </stream:stream>
*** User 2022-04-04 15:02:41.380 *** 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-04-04 15:02:41.381 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='c672b0c02b95bde1' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:41.381 *** 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-04-04 15:02:41.381 *** alicE@localhost out <iq type='get' id='18c985e25d656a7846939030d99a2f0d'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-04-04 15:02:41.381 *** alicE@localhost in <iq from='localhost' id='18c985e25d656a7846939030d99a2f0d' 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-04-04 15:02:41.381 *** alicE@localhost out <iq type='set' id='ef991a285114428f848afc53805a2068'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-04-04 15:02:41.382 *** alicE@localhost in <iq from='localhost' id='ef991a285114428f848afc53805a2068' 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-04-04 15:02:41.382 *** alicE@localhost out </stream:stream>
*** User 2022-04-04 15:02:41.382 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-04-04 15:02:41.382 *** =ERROR REPORT==== 4-Apr-2022::15:02:41.382356 === error when trying to register user: <iq from='localhost' id='ef991a285114428f848afc53805a2068' 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-04-04 15:02:41.783 *** 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-04-04 15:02:41.784 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='6f821ae622b3e3b6' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:41.784 *** 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-04-04 15:02:41.784 *** alicE@localhost out <iq type='get' id='ca6f606fe9c339ae5fabfee242ee7a7b'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-04-04 15:02:41.784 *** alicE@localhost in <iq from='localhost' id='ca6f606fe9c339ae5fabfee242ee7a7b' 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-04-04 15:02:41.784 *** alicE@localhost out <iq type='set' id='be9b5d9517d25170e396538a31e5812e'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-04-04 15:02:41.785 *** alicE@localhost in <iq from='localhost' id='be9b5d9517d25170e396538a31e5812e' 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-04-04 15:02:41.785 *** alicE@localhost out </stream:stream>
*** User 2022-04-04 15:02:41.785 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-04-04 15:02:41.785 *** =ERROR REPORT==== 4-Apr-2022::15:02:41.785739 === error when trying to register user: <iq from='localhost' id='be9b5d9517d25170e396538a31e5812e' 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-04-04 15:02:42.186 *** 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-04-04 15:02:42.187 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='f70aa3c311693316' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:42.187 *** 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-04-04 15:02:42.187 *** alicE@localhost out <iq type='get' id='56e592bcaedb78be9108b79f4eff558f'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-04-04 15:02:42.187 *** alicE@localhost in <iq from='localhost' id='56e592bcaedb78be9108b79f4eff558f' 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-04-04 15:02:42.187 *** alicE@localhost out <iq type='set' id='310cf260a73ec09002510b053514e827'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-04-04 15:02:42.187 *** alicE@localhost in <iq from='localhost' id='310cf260a73ec09002510b053514e827' 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-04-04 15:02:42.188 *** alicE@localhost out </stream:stream>
*** User 2022-04-04 15:02:42.188 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-04-04 15:02:42.188 *** =ERROR REPORT==== 4-Apr-2022::15:02:42.188239 === error when trying to register user: <iq from='localhost' id='310cf260a73ec09002510b053514e827' 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-04-04 15:02:42.589 *** 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-04-04 15:02:42.590 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='6998737e2fd7d48a' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:42.590 *** 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-04-04 15:02:42.590 *** alicE@localhost out <iq type='get' id='81866deb261eb49a48062ae2d9eef329'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-04-04 15:02:42.591 *** alicE@localhost in <iq from='localhost' id='81866deb261eb49a48062ae2d9eef329' 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-04-04 15:02:42.591 *** alicE@localhost out <iq type='set' id='388a5484b9e991341436959a6b88b123'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-04-04 15:02:42.591 *** alicE@localhost in <iq from='localhost' id='388a5484b9e991341436959a6b88b123' 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-04-04 15:02:42.591 *** alicE@localhost out </stream:stream>
*** User 2022-04-04 15:02:42.592 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-04-04 15:02:42.592 *** =ERROR REPORT==== 4-Apr-2022::15:02:42.592117 === error when trying to register user: <iq from='localhost' id='388a5484b9e991341436959a6b88b123' 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-04-04 15:02:42.993 *** 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-04-04 15:02:42.994 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='8a2a589364224376' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:42.994 *** 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-04-04 15:02:42.994 *** alicE@localhost out <iq type='get' id='0d8e0c6a456364a7162c1be48dd7d802'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-04-04 15:02:42.994 *** alicE@localhost in <iq from='localhost' id='0d8e0c6a456364a7162c1be48dd7d802' 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-04-04 15:02:42.994 *** alicE@localhost out <iq type='set' id='dc38295a0494867f464c6550df7c980b'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-04-04 15:02:42.995 *** alicE@localhost in <iq from='localhost' id='dc38295a0494867f464c6550df7c980b' 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-04-04 15:02:42.995 *** alicE@localhost out </stream:stream>
*** User 2022-04-04 15:02:42.995 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-04-04 15:02:42.995 *** =ERROR REPORT==== 4-Apr-2022::15:02:42.995635 === error when trying to register user: <iq from='localhost' id='dc38295a0494867f464c6550df7c980b' 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-04-04 15:02:43.396 *** 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-04-04 15:02:43.397 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='0a83517c13cdb483' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:43.397 *** 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-04-04 15:02:43.397 *** alicE@localhost out <iq type='get' id='ea0b0e429d2f6e2305bff49d0e2728fd'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-04-04 15:02:43.397 *** alicE@localhost in <iq from='localhost' id='ea0b0e429d2f6e2305bff49d0e2728fd' 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-04-04 15:02:43.397 *** alicE@localhost out <iq type='set' id='fd8b5d7c8cd2b58bd62ba22ab391b215'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-04-04 15:02:43.398 *** alicE@localhost in <iq from='localhost' id='fd8b5d7c8cd2b58bd62ba22ab391b215' 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-04-04 15:02:43.398 *** alicE@localhost out </stream:stream>
*** User 2022-04-04 15:02:43.398 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-04-04 15:02:43.398 *** =ERROR REPORT==== 4-Apr-2022::15:02:43.398456 === error when trying to register user: <iq from='localhost' id='fd8b5d7c8cd2b58bd62ba22ab391b215' 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-04-04 15:02:43.799 *** 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-04-04 15:02:43.800 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='00c73cdce8f60020' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:43.800 *** 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-04-04 15:02:43.800 *** alicE@localhost out <iq type='get' id='6836c257f99d7b4e6be649c5d351d4d0'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-04-04 15:02:43.800 *** alicE@localhost in <iq from='localhost' id='6836c257f99d7b4e6be649c5d351d4d0' 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-04-04 15:02:43.800 *** alicE@localhost out <iq type='set' id='a0b9598883dc9d440bcffc90638c6dcf'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-04-04 15:02:43.801 *** alicE@localhost in <iq from='localhost' id='a0b9598883dc9d440bcffc90638c6dcf' 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-04-04 15:02:43.801 *** alicE@localhost out </stream:stream>
*** User 2022-04-04 15:02:43.801 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-04-04 15:02:43.801 *** =ERROR REPORT==== 4-Apr-2022::15:02:43.801387 === error when trying to register user: <iq from='localhost' id='a0b9598883dc9d440bcffc90638c6dcf' 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-04-04 15:02:44.202 *** 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-04-04 15:02:44.203 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='a404db72160b96b8' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:44.203 *** 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-04-04 15:02:44.203 *** alicE@localhost out <iq type='get' id='a818a85f8c2f429e07c9ddb98d56e493'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-04-04 15:02:44.203 *** alicE@localhost in <iq from='localhost' id='a818a85f8c2f429e07c9ddb98d56e493' 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-04-04 15:02:44.203 *** alicE@localhost out <iq type='set' id='96ff7868f56dbbfa88422ad7ac49e02d'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-04-04 15:02:44.205 *** alicE@localhost in <iq from='localhost' id='96ff7868f56dbbfa88422ad7ac49e02d' 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-04-04 15:02:44.205 *** alicE@localhost out </stream:stream>
*** User 2022-04-04 15:02:44.205 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-04-04 15:02:44.205 *** =INFO REPORT==== 4-Apr-2022::15:02:44.205626 === user already existed: <iq from='localhost' id='96ff7868f56dbbfa88422ad7ac49e02d' 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-04-04 15:02:44.207 *** 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-04-04 15:02:44.208 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='72d510b89a17b829' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:44.208 *** 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-04-04 15:02:44.208 *** alicE@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFAG1hdHlncnlzYQ==</auth>
*** User 2022-04-04 15:02:44.209 *** alicE@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-04-04 15:02:44.209 *** 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-04-04 15:02:44.209 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='1fa4261c5f0ae62c' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:44.209 *** 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-04-04 15:02:44.209 *** alicE@localhost out <iq type='set' id='9d8325915c29fa122d8f6a34ecd26126'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2022-04-04 15:02:44.210 *** alicE@localhost in <iq id='9d8325915c29fa122d8f6a34ecd26126' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alicE@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2022-04-04 15:02:44.210 *** alicE@localhost/escalus-default-resource out <iq type='set' id='3655caf00e471579d207413040fbdc59'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-04-04 15:02:44.210 *** alicE@localhost/escalus-default-resource in <iq type='result' id='3655caf00e471579d207413040fbdc59'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-04-04 15:02:44.210 *** alicE@localhost/escalus-default-resource out <iq type='set' id='3cbc0ea3d2b4c57d8c953a21e2d71ca3'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2022-04-04 15:02:44.211 *** alicE@localhost/escalus-default-resource in <iq from='' to='alicE@localhost/escalus-default-resource' id='3cbc0ea3d2b4c57d8c953a21e2d71ca3' type='result'/>
*** User 2022-04-04 15:02:44.211 *** alicE@localhost/escalus-default-resource out </stream:stream>
*** User 2022-04-04 15:02:44.211 *** alicE@localhost/escalus-default-resource in </stream:stream>
*** User 2022-04-04 15:02:44.212 *** 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-04-04 15:02:44.212 *** bOb@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='f0fa722d150d99de' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-04-04 15:02:44.212 *** 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-04-04 15:02:44.212 *** bOb@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYgBtYWtyb2xpa2E=</auth>
*** User 2022-04-04 15:02:44.213 *** 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.1697.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,<<"f0fa722d150d99de">>}]}, [{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}]
=== Ended at 2022-04-04 15:02:44 === successfully completed test case === === Returned value: {ok,ok}
Test run history | Top level test index | Latest test result