=== Test case: websockets_SUITE:chat_msg/1 (click for source code) === Config value: [{user,geralt}, {watchdog,<0.2181.2>}, {mim_data_dir,"/home/circleci/project/big_tests/tests/websockets_SUITE_data"}, {preset,"elasticsearch_and_cassandra_mnesia"}, {tc_logfile,"/home/circleci/project/big_tests/ct_report/ct_run.test@47358c7e636c.2022-06-22_09.17.07/big_tests.tests.websockets_SUITE.logs/run.2022-06-22_09.30.55/websockets_suite.chat_msg.html"}, {tc_group_properties,[{name,ws_chat},{repeat_until_all_ok,3},sequence]}, {tc_group_path,[]}, {data_dir,"/home/circleci/project/big_tests/_build/default/lib/mongoose_tests/ebin/websockets_SUITE_data/"}, {priv_dir,"/home/circleci/project/big_tests/ct_report/ct_run.test@47358c7e636c.2022-06-22_09.17.07/big_tests.tests.websockets_SUITE.logs/run.2022-06-22_09.30.55/log_private/"}, {escalus_users,[{alice,[{username,<<"alicE">>}, {server,<<"localhost">>}, {password,<<"matygrysa">>}]}, {geralt,[{username,<<"geralt">>}, {server,<<"localhost">>}, {password,<<"witcher">>}, {transport,escalus_ws}, {port,5280}, {wspath,<<"/ws-xmpp">>}]}, {geralt_s,[{username,<<"geralt_s">>}, {server,<<"localhost">>}, {password,<<"witcher_s">>}, {transport,escalus_ws}, {ssl,true}, {port,5285}, {wspath,<<"/ws-xmpp">>}]}, {carol,[{username,<<"carol">>}, {server,<<"localhost">>}, {password,<<"jinglebells">>}, {transport,escalus_bosh}, {path,<<"/http-bind">>}, {port,5280}]}]}] === Current directory is "/home/circleci/project/big_tests/ct_report/ct_run.test@47358c7e636c.2022-06-22_09.17.07" === Started at 2022-06-22 09:30:55
*** User 2022-06-22 09:30:55.511 ***🔗 alicE@localhost/res1 out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-06-22 09:30:55.512 ***🔗 alicE@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='e901aeffdca65175' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-06-22 09:30:55.512 ***🔗 alicE@localhost/res1 in <stream:features> <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'/> <compression xmlns='http://jabber.org/features/compress'> <method>zlib</method> </compression> <mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'> <mechanism>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-06-22 09:30:55.512 ***🔗 alicE@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFAG1hdHlncnlzYQ==</auth>
*** User 2022-06-22 09:30:55.512 ***🔗 alicE@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-06-22 09:30:55.513 ***🔗 alicE@localhost/res1 out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-06-22 09:30:55.513 ***🔗 alicE@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='23065ec5764ccd0f' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-06-22 09:30:55.513 ***🔗 alicE@localhost/res1 in <stream:features> <compression xmlns='http://jabber.org/features/compress'> <method>zlib</method> </compression> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> <register xmlns='http://jabber.org/features/iq-register'/> <amp xmlns='http://jabber.org/feature/amp'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2022-06-22 09:30:55.513 ***🔗 alicE@localhost/res1 out <iq type='set' id='6980b5e4eb8df5d3347a1d289138207e'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-06-22 09:30:55.513 ***🔗 alicE@localhost/res1 in <iq id='6980b5e4eb8df5d3347a1d289138207e' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alice@localhost/res1</jid> </bind> </iq>
*** User 2022-06-22 09:30:55.513 ***🔗 alice@localhost/res1 out <iq type='set' id='3c293405384a673de3d137d984133d83'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-06-22 09:30:55.513 ***🔗 alice@localhost/res1 in <iq type='result' id='3c293405384a673de3d137d984133d83'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-06-22 09:30:55.513 ***🔗 alice@localhost/res1 out <presence/>
*** User 2022-06-22 09:30:55.514 ***🔗 alice@localhost/res1 in <presence from='alice@localhost/res1' to='alice@localhost/res1' xml:lang='en'/>
*** User 2022-06-22 09:30:55.515 ***🔗 geralt@localhost/res1 out <open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-06-22 09:30:55.515 ***🔗 geralt@localhost/res1 in <open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='2c59c4c1c91e018a' from='localhost'/>
*** User 2022-06-22 09:30:55.515 ***🔗 geralt@localhost/res1 in <features xmlns='http://etherx.jabber.org/streams'> <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'/> </features>
*** User 2022-06-22 09:30:55.515 ***🔗 geralt@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGdlcmFsdAB3aXRjaGVy</auth>
*** User 2022-06-22 09:30:55.516 ***🔗 geralt@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-06-22 09:30:55.516 ***🔗 geralt@localhost/res1 out <open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-06-22 09:30:55.516 ***🔗 geralt@localhost/res1 in <open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='6670e62feb169118' from='localhost'/>
*** User 2022-06-22 09:30:55.516 ***🔗 geralt@localhost/res1 in <features xmlns='http://etherx.jabber.org/streams'> <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'/> </features>
*** User 2022-06-22 09:30:55.516 ***🔗 geralt@localhost/res1 out <iq type='set' id='ebd0320b9392635efa0c0e587bf8b2dc'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-06-22 09:30:55.516 ***🔗 geralt@localhost/res1 in <iq id='ebd0320b9392635efa0c0e587bf8b2dc' type='result' xmlns='jabber:client'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>geralt@localhost/res1</jid> </bind> </iq>
*** User 2022-06-22 09:30:55.516 ***🔗 geralt@localhost/res1 out <iq type='set' id='2ab19fc3842f8f27df21f7c23a4c06c8'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-06-22 09:30:55.516 ***🔗 geralt@localhost/res1 in <iq type='result' id='2ab19fc3842f8f27df21f7c23a4c06c8' xmlns='jabber:client'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-06-22 09:30:55.517 ***🔗 geralt@localhost/res1 out <presence/>
*** User 2022-06-22 09:30:55.517 ***🔗 geralt@localhost/res1 in <presence from='geralt@localhost/res1' to='geralt@localhost/res1' xmlns='jabber:client'/>
*** User 2022-06-22 09:30:55.517 ***🔗 carol@localhost/res1 out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-06-22 09:30:55.530 ***🔗 carol@localhost/res1 in <stream:stream from='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-06-22 09:30:55.530 ***🔗 carol@localhost/res1 in <stream:features> <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-06-22 09:30:55.530 ***🔗 carol@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGNhcm9sAGppbmdsZWJlbGxz</auth>
*** User 2022-06-22 09:30:55.531 ***🔗 carol@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-06-22 09:30:55.531 ***🔗 carol@localhost/res1 out <stream:stream to='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-06-22 09:30:55.543 ***🔗 carol@localhost/res1 in <stream:stream from='localhost' version='1.0' xml:lang='en' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>
*** User 2022-06-22 09:30:55.543 ***🔗 carol@localhost/res1 in <stream:features> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> <register xmlns='http://jabber.org/features/iq-register'/> <amp xmlns='http://jabber.org/feature/amp'/> <sm xmlns='urn:xmpp:sm:3'/> </stream:features>
*** User 2022-06-22 09:30:55.543 ***🔗 carol@localhost/res1 out <iq type='set' id='1e1c6cb73cdaaeb67dcefefc0f3473ac'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-06-22 09:30:55.543 ***🔗 carol@localhost/res1 in <iq xmlns='jabber:client' id='1e1c6cb73cdaaeb67dcefefc0f3473ac' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>carol@localhost/res1</jid> </bind> </iq>
*** User 2022-06-22 09:30:55.543 ***🔗 carol@localhost/res1 out <iq type='set' id='a38e3d4314d1ae4d658b64892b4685ff'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-06-22 09:30:55.544 ***🔗 carol@localhost/res1 in <iq xmlns='jabber:client' type='result' id='a38e3d4314d1ae4d658b64892b4685ff'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-06-22 09:30:55.544 ***🔗 carol@localhost/res1 out <presence/>
*** User 2022-06-22 09:30:55.545 ***🔗 carol@localhost/res1 in <presence xmlns='jabber:client' from='carol@localhost/res1' to='carol@localhost/res1' xml:lang='en'/>
*** User 2022-06-22 09:30:55.545 ***🔗 alice@localhost/res1 out <message to='geralt@localhost/res1' type='chat'> <body>Hi!</body> </message>
*** User 2022-06-22 09:30:55.545 ***🔗 geralt@localhost/res1 in <message from='alice@localhost/res1' to='geralt@localhost/res1' xml:lang='en' type='chat' xmlns='jabber:client'> <body>Hi!</body> </message>
*** User 2022-06-22 09:30:55.545 ***🔗 geralt@localhost/res1 out <message to='alice@localhost/res1' type='chat'> <body>Hello!</body> </message>
*** User 2022-06-22 09:30:55.546 ***🔗 alice@localhost/res1 in <message from='geralt@localhost/res1' to='alice@localhost/res1' type='chat' xmlns='jabber:client'> <body>Hello!</body> </message>
*** User 2022-06-22 09:30:55.546 ***🔗 geralt@localhost/res1 out <message to='carol@localhost/res1' type='chat'> <body>Hey!</body> </message>
*** User 2022-06-22 09:30:55.546 ***🔗 carol@localhost/res1 in <message from='geralt@localhost/res1' to='carol@localhost/res1' type='chat' xmlns='jabber:client'> <body>Hey!</body> </message>
*** User 2022-06-22 09:30:55.546 ***🔗 carol@localhost/res1 out </stream:stream>
*** User 2022-06-22 09:30:55.547 ***🔗 carol@localhost/res1 in </stream:stream>
*** User 2022-06-22 09:30:55.547 ***🔗 geralt@localhost/res1 out <close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-06-22 09:30:55.547 ***🔗 geralt@localhost/res1 in <close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-06-22 09:30:55.548 ***🔗 alice@localhost/res1 out </stream:stream>
*** User 2022-06-22 09:30:55.548 ***🔗 alice@localhost/res1 in </stream:stream>
*** System report during websockets_SUITE:chat_msg/1 in ws_chat 2022-06-22 09:30:55.548 ***🔗 =ERROR REPORT==== 22-Jun-2022::09:30:55.548392 === ** State machine <0.2194.2> terminating ** Last event = {cast,{ws_send,<0.2193.2>, #Ref<0.3883521081.3670802434.164952>,close}} ** When server state = {connected, {state,<0.2193.2>, {up,#Ref<0.3883521081.3670802434.164949>}, "localhost",5280,<<"http">>,"localhost",5280, [], #{protocols => [http],transport => tcp}, undefined,#Port<0.6501>,gun_tcp,true, {tcp,tcp_closed,tcp_error}, gun_http, {http_state,#Port<0.6501>,gun_tcp,#{}, 'HTTP/1.1',keepalive,<<>>,undefined,[], head, {0,0}, head}, undefined,gun_default_event_h,undefined}} ** Reason for termination = error:{'function not exported', {gun_http,ws_send,6}} ** Callback modules = [gun] ** Callback mode = state_functions ** Stacktrace = ** [{gun,connected,3, [{file,"/home/circleci/project/big_tests/_build/default/lib/gun/src/gun.erl"}, {line,1301}]}, {gen_statem,loop_state_callback,11,[{file,"gen_statem.erl"},{line,1419}]}, {proc_lib,init_p_do_apply,3,[{file,"proc_lib.erl"},{line,240}]}]
*** System report during websockets_SUITE:chat_msg/1 in ws_chat 2022-06-22 09:30:55.549 ***🔗 =CRASH REPORT==== 22-Jun-2022::09:30:55.548858 === crasher: initial call: gun:init/1 pid: <0.2194.2> registered_name: [] exception error: undefined function gun_http:ws_send/6 in function gun:connected/3 (/home/circleci/project/big_tests/_build/default/lib/gun/src/gun.erl, line 1301) in call from gen_statem:loop_state_callback/11 (gen_statem.erl, line 1419) ancestors: [gun_conns_sup,gun_sup,<0.1391.0>] message_queue_len: 1 messages: [{'DOWN',#Ref<0.3883521081.3670802434.164949>,process, <0.2193.2>,normal}] links: [<0.1393.0>,#Port<0.6501>] dictionary: [] trap_exit: false status: running heap_size: 6772 stack_size: 28 reductions: 17191 neighbours:
*** System report during websockets_SUITE:chat_msg/1 in ws_chat 2022-06-22 09:30:55.549 ***🔗 =SUPERVISOR REPORT==== 22-Jun-2022::09:30:55.549203 === supervisor: {local,gun_conns_sup} errorContext: child_terminated reason: {undef, [{gun_http,ws_send, [close, {http_state,#Port<0.6501>,gun_tcp,#{},'HTTP/1.1', keepalive,<<>>,undefined,[],head, {0,0}, head}, #Ref<0.3883521081.3670802434.164952>,<0.2193.2>, gun_default_event_h,undefined], []}, {gun,connected,3, [{file, "/home/circleci/project/big_tests/_build/default/lib/gun/src/gun.erl"}, {line,1301}]}, {gen_statem,loop_state_callback,11, [{file,"gen_statem.erl"},{line,1419}]}, {proc_lib,init_p_do_apply,3, [{file,"proc_lib.erl"},{line,240}]}]} offender: [{pid,<0.2194.2>}, {id,gun}, {mfargs,{gun,start_link,undefined}}, {restart_type,temporary}, {significant,false}, {shutdown,5000}, {child_type,worker}]
=== Ended at 2022-06-22 09:30:55 === successfully completed test case === === Returned value: ok
Test run history | Top level test index | Latest test result