=== Test case: muc_SUITE:deny_nickname_change_conflict/1 (click for source code)

=== Config value:

    [{watchdog,<0.66750.0>},
     {preset,"pgsql_mnesia"},
     {mim_data_dir,"/home/circleci/project/big_tests/tests/muc_SUITE_data"},
     {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@82e417e9e7f3.2024-04-15_15.52.32/big_tests.tests.muc_SUITE.logs/run.2024-04-15_16.03.15/muc_suite.deny_nickname_change_conflict.203138.html"},
     {tc_group_properties,[{name,occupant},parallel]},
     {tc_group_path,[]},
     {data_dir,"/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/muc_SUITE_data/"},
     {priv_dir,"/home/circleci/project/big_tests/ct_report/ct_run.test@82e417e9e7f3.2024-04-15_15.52.32/big_tests.tests.muc_SUITE.logs/run.2024-04-15_16.03.15/log_private/"},
     {{saved_modules,mongooseim@localhost,<<"test type">>},
      #{mod_vcard =>
            #{matches => 30,
              host => {prefix,<<"vjud.">>},
              search => true,backend => rdbms,iqdisc => parallel},
        mod_roster =>
            #{backend => rdbms,iqdisc => one_queue,versioning => false,
              store_current_id => false},
        mod_sic => #{iqdisc => one_queue},
        mod_amp => #{},
        mod_register =>
            #{access => register,iqdisc => one_queue,
              registration_watchers => [],password_strength => 0,
              ip_access => [{allow,"127.0.0.0/8"},{deny,"0.0.0.0/0"}]},
        mod_disco =>
            #{iqdisc => one_queue,users_can_see_hidden_services => false,
              server_info => [],extra_domains => []},
        mod_presence => #{},
        mod_stream_management =>
            #{buffer => true,ack => true,backend => mnesia,
              stale_h =>
                  #{enabled => false,repeat_after => 1800,geriatric => 3600},
              buffer_max => 100,ack_freq => 1,resume_timeout => 600},
        mod_adhoc => #{iqdisc => one_queue,report_commands_node => false},
        mod_cache_users =>
            #{strategy => fifo,number_of_segments => 5,time_to_live => 2},
        mod_carboncopy => #{iqdisc => no_queue},
        mod_bosh =>
            #{backend => mnesia,inactivity => 30,max_pause => 120,
              max_wait => infinity,server_acks => false}}},
     {escalus_users,[{alice,[{username,<<"alicE">>},
                             {server,<<"domain.example.com">>},
                             {host,<<"localhost">>},
                             {password,<<"matygrysa">>}]},
                     {bob,[{username,<<"bOb">>},
                           {server,<<"domain.example.com">>},
                           {host,<<"localhost">>},
                           {password,<<"makrolika">>}]},
                     {kate,[{username,<<"kate">>},
                            {server,<<"domain.example.com">>},
                            {host,<<"localhost">>},
                            {password,<<"makrowe;p">>}]}]}]

=== Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@82e417e9e7f3.2024-04-15_15.52.32"

=== Started at 2024-04-15 16:03:28


*** CT 2024-04-15 16:03:28.229 *** View log from node mongooseim@localhost when started🔗 mongooseim@localhost_2326.html
Could not find element wait_for_parallel_writer in Config.


*** User 2024-04-15 16:03:28.381 ***🔗
alicE_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-15 16:03:28.383 ***🔗
alicE_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='aa3084ff8f83009e' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2024-04-15 16:03:28.384 ***🔗
alicE_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:features>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
	<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
		<mechanism>SCRAM-SHA-256</mechanism>
		<mechanism>PLAIN</mechanism>
	</mechanisms>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-15 16:03:28.384 ***🔗
alicE_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFX2Rlbnlfbmlja25hbWVfY2hhbmdlX2NvbmZsaWN0XzI3NDYAbWF0eWdyeXNh</auth>



*** User 2024-04-15 16:03:28.385 ***🔗
alicE_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2024-04-15 16:03:28.385 ***🔗
alicE_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-15 16:03:28.386 ***🔗
alicE_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='9ef200e4a6abbb5b' from='domain.example.com' version='1.0' xml:lang='en' to='alice_deny_nickname_change_conflict_2746@domain.example.com'>

*** User 2024-04-15 16:03:28.386 ***🔗
alicE_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:features>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-15 16:03:28.386 ***🔗
alicE_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<iq type='set' id='8828dcbc522aff9424df6eeff5e2ce54'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2024-04-15 16:03:28.387 ***🔗
alicE_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<iq id='8828dcbc522aff9424df6eeff5e2ce54' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>alice_deny_nickname_change_conflict_2746@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2024-04-15 16:03:28.387 ***🔗
alice_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<iq type='set' id='595a8f6a77497d3b0a7e4ff3fb54cf7d'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-15 16:03:28.389 ***🔗
alice_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<iq from='domain.example.com' to='alice_deny_nickname_change_conflict_2746@domain.example.com/res1' id='595a8f6a77497d3b0a7e4ff3fb54cf7d' type='result'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-15 16:03:28.390 ***🔗
alice_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<presence/>



*** User 2024-04-15 16:03:28.392 ***🔗
alice_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<presence from='alice_deny_nickname_change_conflict_2746@domain.example.com/res1' to='alice_deny_nickname_change_conflict_2746@domain.example.com/res1'/>



*** User 2024-04-15 16:03:28.394 ***🔗
bOb_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-15 16:03:28.396 ***🔗
bOb_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='0f7dde00b867e2af' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2024-04-15 16:03:28.396 ***🔗
bOb_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:features>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
	<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
		<mechanism>SCRAM-SHA-256</mechanism>
		<mechanism>PLAIN</mechanism>
	</mechanisms>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-15 16:03:28.396 ***🔗
bOb_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGJPYl9kZW55X25pY2tuYW1lX2NoYW5nZV9jb25mbGljdF8yNzQ2AG1ha3JvbGlrYQ==</auth>



*** User 2024-04-15 16:03:28.398 ***🔗
bOb_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2024-04-15 16:03:28.398 ***🔗
bOb_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-15 16:03:28.399 ***🔗
bOb_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='447e3e5485521ac5' from='domain.example.com' version='1.0' xml:lang='en' to='bob_deny_nickname_change_conflict_2746@domain.example.com'>

*** User 2024-04-15 16:03:28.399 ***🔗
bOb_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:features>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-15 16:03:28.399 ***🔗
bOb_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<iq type='set' id='458bea89b2a8a02c461fc2646b4fb339'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2024-04-15 16:03:28.400 ***🔗
bOb_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<iq id='458bea89b2a8a02c461fc2646b4fb339' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>bob_deny_nickname_change_conflict_2746@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2024-04-15 16:03:28.400 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<iq type='set' id='b4ffa885665fb772a36050d6f4ba5709'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-15 16:03:28.401 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<iq from='domain.example.com' to='bob_deny_nickname_change_conflict_2746@domain.example.com/res1' id='b4ffa885665fb772a36050d6f4ba5709' type='result'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-15 16:03:28.402 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<presence/>



*** User 2024-04-15 16:03:28.403 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<presence from='bob_deny_nickname_change_conflict_2746@domain.example.com/res1' to='bob_deny_nickname_change_conflict_2746@domain.example.com/res1'/>



*** User 2024-04-15 16:03:28.404 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-15 16:03:28.404 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='9a5fcf1d53f9a77c' from='domain.example.com' version='1.0' xml:lang='en'>

*** User 2024-04-15 16:03:28.404 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:features>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/>
	<mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
		<mechanism>SCRAM-SHA-256</mechanism>
		<mechanism>PLAIN</mechanism>
	</mechanisms>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-15 16:03:28.405 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGthdGVfZGVueV9uaWNrbmFtZV9jaGFuZ2VfY29uZmxpY3RfMjc0NgBtYWtyb3dlO3A=</auth>



*** User 2024-04-15 16:03:28.467 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>



*** User 2024-04-15 16:03:28.467 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<stream:stream to='domain.example.com' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>

*** User 2024-04-15 16:03:28.468 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='be4671ee23fad907' from='domain.example.com' version='1.0' xml:lang='en' to='kate_deny_nickname_change_conflict_2746@domain.example.com'>

*** User 2024-04-15 16:03:28.468 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<stream:features>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/>
	<register xmlns='http://jabber.org/features/iq-register'/>
	<amp xmlns='http://jabber.org/feature/amp'/>
	<sm xmlns='urn:xmpp:sm:3'/>
</stream:features>



*** User 2024-04-15 16:03:28.468 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<iq type='set' id='91fc629ebec312ea6df3868e608ff8b5'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<resource>res1</resource>
	</bind>
</iq>



*** User 2024-04-15 16:03:28.469 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<iq id='91fc629ebec312ea6df3868e608ff8b5' type='result'>
	<bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'>
		<jid>kate_deny_nickname_change_conflict_2746@domain.example.com/res1</jid>
	</bind>
</iq>



*** User 2024-04-15 16:03:28.469 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<iq type='set' id='19046c5087476bbf4e401910ed0b0c20'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-15 16:03:28.470 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<iq from='domain.example.com' to='kate_deny_nickname_change_conflict_2746@domain.example.com/res1' id='19046c5087476bbf4e401910ed0b0c20' type='result'>
	<session xmlns='urn:ietf:params:xml:ns:xmpp-session'/>
</iq>



*** User 2024-04-15 16:03:28.470 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<presence/>



*** User 2024-04-15 16:03:28.472 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<presence from='kate_deny_nickname_change_conflict_2746@domain.example.com/res1' to='kate_deny_nickname_change_conflict_2746@domain.example.com/res1'/>



*** User 2024-04-15 16:03:28.472 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<presence to='room-alice_deny_nickname_change_conflict_2746@groupchats.domain.example.com/bob'>
	<x xmlns='http://jabber.org/protocol/muc'/>
</presence>



*** User 2024-04-15 16:03:28.474 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<presence from='room-alice_deny_nickname_change_conflict_2746@groupchats.domain.example.com/bob' to='bob_deny_nickname_change_conflict_2746@domain.example.com/res1'>
	<x xmlns='http://jabber.org/protocol/muc'>
		<item affiliation='none' role='participant'/>
		<status code='110'/>
		<status code='201'/>
	</x>
</presence>



*** User 2024-04-15 16:03:28.474 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<message from='room-alice_deny_nickname_change_conflict_2746@groupchats.domain.example.com' to='bob_deny_nickname_change_conflict_2746@domain.example.com/res1' type='groupchat'>
	<subject/>
	<body/>
</message>



*** User 2024-04-15 16:03:28.474 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<presence to='room-alice_deny_nickname_change_conflict_2746@groupchats.domain.example.com/eve'>
	<x xmlns='http://jabber.org/protocol/muc'/>
</presence>



*** User 2024-04-15 16:03:28.476 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<presence from='room-alice_deny_nickname_change_conflict_2746@groupchats.domain.example.com/eve' to='bob_deny_nickname_change_conflict_2746@domain.example.com/res1'>
	<x xmlns='http://jabber.org/protocol/muc'>
		<item affiliation='none' role='participant'/>
	</x>
</presence>



*** User 2024-04-15 16:03:28.477 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<presence from='room-alice_deny_nickname_change_conflict_2746@groupchats.domain.example.com/bob' to='kate_deny_nickname_change_conflict_2746@domain.example.com/res1'>
	<x xmlns='http://jabber.org/protocol/muc#user'>
		<item affiliation='none' role='participant'/>
	</x>
</presence>



*** User 2024-04-15 16:03:28.477 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<presence from='room-alice_deny_nickname_change_conflict_2746@groupchats.domain.example.com/eve' to='kate_deny_nickname_change_conflict_2746@domain.example.com/res1'>
	<x xmlns='http://jabber.org/protocol/muc'>
		<item affiliation='none' role='participant'/>
		<status code='110'/>
	</x>
</presence>



*** User 2024-04-15 16:03:28.477 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<message from='room-alice_deny_nickname_change_conflict_2746@groupchats.domain.example.com' to='kate_deny_nickname_change_conflict_2746@domain.example.com/res1' type='groupchat'>
	<subject/>
	<body/>
</message>



*** User 2024-04-15 16:03:28.477 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 out
<presence to='room-alice_deny_nickname_change_conflict_2746@groupchats.domain.example.com/eve'/>



*** User 2024-04-15 16:03:28.479 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 in
<presence from='room-alice_deny_nickname_change_conflict_2746@groupchats.domain.example.com/eve' to='bob_deny_nickname_change_conflict_2746@domain.example.com/res1' type='error'>
	<error code='409' type='cancel'>
		<conflict xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/>
		<text xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>That nickname is already in use by another occupant</text>
	</error>
</presence>



*** User 2024-04-15 16:03:28.479 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 out
</stream:stream>

*** User 2024-04-15 16:03:28.479 ***🔗
kate_deny_nickname_change_conflict_2746@domain.example.com/res1 in
</stream:stream>

*** User 2024-04-15 16:03:28.479 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 out
</stream:stream>

*** User 2024-04-15 16:03:28.480 ***🔗
bob_deny_nickname_change_conflict_2746@domain.example.com/res1 in
</stream:stream>

*** User 2024-04-15 16:03:28.480 ***🔗
alice_deny_nickname_change_conflict_2746@domain.example.com/res1 out
</stream:stream>

*** User 2024-04-15 16:03:28.480 ***🔗
alice_deny_nickname_change_conflict_2746@domain.example.com/res1 in
</stream:stream>

*** User 2024-04-15 16:03:28.481 ***🔗
waiting for room_archive_size is done in 0 miliseconds
*** CT 2024-04-15 16:03:28.571 *** View log from node mongooseim@localhost when finished🔗 mongooseim@localhost_2442.html



=== Ended at 2024-04-15 16:03:28
=== successfully completed test case
=== === Returned value: ok