=== Test case: accounts_SUITE:registration_timeout/1 (click for source code) === Config value: [{watchdog,<0.1635.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,"internal_mnesia"}, {tc_logfile, "/home/circleci/project/big_tests/ct_report/ct_run.test@34a9b6d2516c.2022-01-27_15.25.07/big_tests.tests.accounts_SUITE.logs/run.2022-01-27_15.25.10/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@34a9b6d2516c.2022-01-27_15.25.07/big_tests.tests.accounts_SUITE.logs/run.2022-01-27_15.25.10/log_private/"}, {config_backup,#{registration_timeout => {ok,infinity}}}] === Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@34a9b6d2516c.2022-01-27_15.25.07" === Started at 2022-01-27 15:25:11
*** User 2022-01-27 15:25:11.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-01-27 15:25:11.590 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='6a342fa6a6787cfa' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:11.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-01-27 15:25:11.590 *** alicE@localhost out <iq type='get' id='ae65a9a7a86da59dd87a3679d2598ce9'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:25:11.590 *** alicE@localhost in <iq from='localhost' id='ae65a9a7a86da59dd87a3679d2598ce9' 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:25:11.590 *** alicE@localhost out <iq type='set' id='b48ac5173911bae8c22143c0b0fde93c'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:25:11.594 *** alicE@localhost in <iq from='localhost' id='b48ac5173911bae8c22143c0b0fde93c' type='result'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:25:11.595 *** alicE@localhost out </stream:stream>
*** User 2022-01-27 15:25:11.595 *** alicE@localhost in </stream:stream>
*** User 2022-01-27 15:25:11.595 *** 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-27 15:25:11.596 *** bOb@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='8bf30e608881ca87' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:11.596 *** 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-27 15:25:11.596 *** bOb@localhost out <iq type='get' id='d94bd1747206b47fe3e0713f6bf3defd'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:25:11.596 *** bOb@localhost in <iq from='localhost' id='d94bd1747206b47fe3e0713f6bf3defd' 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:25:11.596 *** bOb@localhost out <iq type='set' id='801f20206486376820bc589c88dc418a'> <query xmlns='jabber:iq:register'> <username>bOb</username> <password>makrolika</password> </query> </iq>
*** User 2022-01-27 15:25:11.597 *** bOb@localhost in <iq from='localhost' id='801f20206486376820bc589c88dc418a' 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-27 15:25:11.597 *** bOb@localhost out </stream:stream>
*** User 2022-01-27 15:25:11.597 *** bOb@localhost in </stream:stream>
*** User 2022-01-27 15:25:11.598 *** 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-27 15:25:11.598 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='b1327c64ffe1f62c' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:11.598 *** 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-27 15:25:11.598 *** alicE@localhost out <iq type='get' id='e92a2fbbf9da9b4ad3174a1837e82d58'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:25:11.598 *** alicE@localhost in <iq from='localhost' id='e92a2fbbf9da9b4ad3174a1837e82d58' 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:25:11.598 *** alicE@localhost out <iq type='set' id='0fba09f38568d095b76b47b059644aab'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:25:11.599 *** alicE@localhost in <iq from='localhost' id='0fba09f38568d095b76b47b059644aab' 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-27 15:25:11.599 *** alicE@localhost out </stream:stream>
*** User 2022-01-27 15:25:11.599 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-27 15:25:11.599 *** =ERROR REPORT==== 27-Jan-2022::15:25:11.599469 === error when trying to register user: <iq from='localhost' id='0fba09f38568d095b76b47b059644aab' 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-27 15:25:12.001 *** 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-27 15:25:12.001 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='6a69a3edd736b538' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:12.001 *** 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-27 15:25:12.001 *** alicE@localhost out <iq type='get' id='8a60df7c4e5ffa7c2112b55e070126ce'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:25:12.002 *** alicE@localhost in <iq from='localhost' id='8a60df7c4e5ffa7c2112b55e070126ce' 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:25:12.002 *** alicE@localhost out <iq type='set' id='5f29c1e0483fc90ac8ff6798f1d320af'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:25:12.002 *** alicE@localhost in <iq from='localhost' id='5f29c1e0483fc90ac8ff6798f1d320af' 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-27 15:25:12.002 *** alicE@localhost out </stream:stream>
*** User 2022-01-27 15:25:12.002 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-27 15:25:12.002 *** =ERROR REPORT==== 27-Jan-2022::15:25:12.002762 === error when trying to register user: <iq from='localhost' id='5f29c1e0483fc90ac8ff6798f1d320af' 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-27 15:25:12.404 *** 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-27 15:25:12.404 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='9b2596c0e88199e6' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:12.404 *** 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-27 15:25:12.404 *** alicE@localhost out <iq type='get' id='1651515c6d0fe1e158cda385c1d5a59e'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:25:12.405 *** alicE@localhost in <iq from='localhost' id='1651515c6d0fe1e158cda385c1d5a59e' 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:25:12.405 *** alicE@localhost out <iq type='set' id='7adae6d0289e8f251a23c4dcfaa5b55e'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:25:12.405 *** alicE@localhost in <iq from='localhost' id='7adae6d0289e8f251a23c4dcfaa5b55e' 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-27 15:25:12.405 *** alicE@localhost out </stream:stream>
*** User 2022-01-27 15:25:12.405 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-27 15:25:12.405 *** =ERROR REPORT==== 27-Jan-2022::15:25:12.405772 === error when trying to register user: <iq from='localhost' id='7adae6d0289e8f251a23c4dcfaa5b55e' 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-27 15:25:12.807 *** 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-27 15:25:12.807 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='f0fd06b4056508fa' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:12.807 *** 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-27 15:25:12.808 *** alicE@localhost out <iq type='get' id='c2ddc7ac410844b5ff7ab6972f4a8a2e'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:25:12.809 *** alicE@localhost in <iq from='localhost' id='c2ddc7ac410844b5ff7ab6972f4a8a2e' 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:25:12.809 *** alicE@localhost out <iq type='set' id='951ebe6244af41fd6616dd391072a7da'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:25:12.810 *** alicE@localhost in <iq from='localhost' id='951ebe6244af41fd6616dd391072a7da' 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-27 15:25:12.810 *** alicE@localhost out </stream:stream>
*** User 2022-01-27 15:25:12.810 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-27 15:25:12.810 *** =ERROR REPORT==== 27-Jan-2022::15:25:12.810676 === error when trying to register user: <iq from='localhost' id='951ebe6244af41fd6616dd391072a7da' 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-27 15:25:13.212 *** 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-27 15:25:13.212 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='2a9862c0a54d58c1' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:13.212 *** 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-27 15:25:13.213 *** alicE@localhost out <iq type='get' id='b03805729b0b80a4a9a5635e75895bc1'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:25:13.213 *** alicE@localhost in <iq from='localhost' id='b03805729b0b80a4a9a5635e75895bc1' 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:25:13.213 *** alicE@localhost out <iq type='set' id='047bf28184ca14b892d6307cdf21ecb2'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:25:13.214 *** alicE@localhost in <iq from='localhost' id='047bf28184ca14b892d6307cdf21ecb2' 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-27 15:25:13.214 *** alicE@localhost out </stream:stream>
*** User 2022-01-27 15:25:13.214 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-27 15:25:13.214 *** =ERROR REPORT==== 27-Jan-2022::15:25:13.214713 === error when trying to register user: <iq from='localhost' id='047bf28184ca14b892d6307cdf21ecb2' 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-27 15:25:13.616 *** 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-27 15:25:13.616 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='8c574ff2f6798290' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:13.617 *** 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-27 15:25:13.617 *** alicE@localhost out <iq type='get' id='dc8b3aa3e65141f766f745e4250ebdeb'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:25:13.617 *** alicE@localhost in <iq from='localhost' id='dc8b3aa3e65141f766f745e4250ebdeb' 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:25:13.617 *** alicE@localhost out <iq type='set' id='7408ec056e7c760fd1f1764b87657e33'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:25:13.618 *** alicE@localhost in <iq from='localhost' id='7408ec056e7c760fd1f1764b87657e33' 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-27 15:25:13.618 *** alicE@localhost out </stream:stream>
*** User 2022-01-27 15:25:13.618 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-27 15:25:13.618 *** =ERROR REPORT==== 27-Jan-2022::15:25:13.618691 === error when trying to register user: <iq from='localhost' id='7408ec056e7c760fd1f1764b87657e33' 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-27 15:25:14.019 *** 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-27 15:25:14.020 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='ceeb56cd89d1f974' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:14.020 *** 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-27 15:25:14.020 *** alicE@localhost out <iq type='get' id='5eeb8dd2392d1857b3aa72ee59a99228'> <query xmlns='jabber:iq:register'/> </iq>
*** User 2022-01-27 15:25:14.021 *** alicE@localhost in <iq from='localhost' id='5eeb8dd2392d1857b3aa72ee59a99228' 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:25:14.021 *** alicE@localhost out <iq type='set' id='d51dd854a95ba43b7fe1cc96d43e50b6'> <query xmlns='jabber:iq:register'> <username>alicE</username> <password>matygrysa</password> </query> </iq>
*** User 2022-01-27 15:25:14.021 *** alicE@localhost in <iq from='localhost' id='d51dd854a95ba43b7fe1cc96d43e50b6' 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-27 15:25:14.022 *** alicE@localhost out </stream:stream>
*** User 2022-01-27 15:25:14.022 *** alicE@localhost in </stream:stream>
*** System report during accounts_SUITE:registration_timeout/1 in registration_timeout 2022-01-27 15:25:14.022 *** =INFO REPORT==== 27-Jan-2022::15:25:14.022388 === user already existed: <iq from='localhost' id='d51dd854a95ba43b7fe1cc96d43e50b6' 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-27 15:25:14.025 *** 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-27 15:25:14.025 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='39ff1f892c531a34' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:14.025 *** 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-27 15:25:14.025 *** alicE@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFAG1hdHlncnlzYQ==</auth>
*** User 2022-01-27 15:25:14.026 *** alicE@localhost in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:25:14.026 *** 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-27 15:25:14.026 *** alicE@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3bf1edadca597461' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:14.026 *** 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-27 15:25:14.026 *** alicE@localhost out <iq type='set' id='61dfe57fd90c40dc44517314db897522'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>escalus-default-resource</resource> </bind> </iq>
*** User 2022-01-27 15:25:14.027 *** alicE@localhost in <iq id='61dfe57fd90c40dc44517314db897522' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alicE@localhost/escalus-default-resource</jid> </bind> </iq>
*** User 2022-01-27 15:25:14.027 *** alicE@localhost/escalus-default-resource out <iq type='set' id='6100539cd87ead309757f77951f8609e'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:25:14.027 *** alicE@localhost/escalus-default-resource in <iq type='result' id='6100539cd87ead309757f77951f8609e'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:25:14.027 *** alicE@localhost/escalus-default-resource out <iq type='set' id='5cdc79883462da48f2dd387da4e606bf'> <query xmlns='jabber:iq:register'> <remove/> </query> </iq>
*** User 2022-01-27 15:25:14.028 *** alicE@localhost/escalus-default-resource in <iq from='' to='alicE@localhost/escalus-default-resource' id='5cdc79883462da48f2dd387da4e606bf' type='result'/>
*** User 2022-01-27 15:25:14.028 *** alicE@localhost/escalus-default-resource out </stream:stream>
*** User 2022-01-27 15:25:14.028 *** alicE@localhost/escalus-default-resource in </stream:stream>
*** User 2022-01-27 15:25:14.029 *** 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-27 15:25:14.035 *** bOb@localhost in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='6f19bd169383cdd5' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:25:14.035 *** 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-27 15:25:14.036 *** bOb@localhost out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYgBtYWtyb2xpa2E=</auth>
*** User 2022-01-27 15:25:14.036 *** 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.1663.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,<<"6f19bd169383cdd5">>}]}, [{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-01-27 15:25:14 === successfully completed test case === === Returned value: {ok,ok}
Test run history | Top level test index | Latest test result