=== Test case: websockets_SUITE:chat_msg/1 (click for source code)
=== Config value:
[{user,geralt_s},
{watchdog,<0.23582.1>},
{mim_data_dir,"/home/circleci/project/big_tests/tests/websockets_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.websockets_SUITE.logs/run.2022-01-27_15.37.34/websockets_suite.chat_msg.88322.html"},
{tc_group_properties,[{name,wss_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@34a9b6d2516c.2022-01-27_15.25.07/big_tests.tests.websockets_SUITE.logs/run.2022-01-27_15.37.34/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@34a9b6d2516c.2022-01-27_15.25.07"
=== Started at 2022-01-27 15:37:35
*** User 2022-01-27 15:37:35.324 *** 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-01-27 15:37:35.324 *** alicE@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='760718575b1bafcf' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:37:35.325 *** 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-01-27 15:37:35.325 *** alicE@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGFsaWNFAG1hdHlncnlzYQ==</auth>
*** User 2022-01-27 15:37:35.325 *** alicE@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:37:35.325 *** 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-01-27 15:37:35.325 *** alicE@localhost/res1 in <stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='7402a25761ff2925' from='localhost' version='1.0' xml:lang='en'>
*** User 2022-01-27 15:37:35.325 *** 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-01-27 15:37:35.326 *** alicE@localhost/res1 out <iq type='set' id='adcb274c7e7e9d3473e5655e6ec2ba8b'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-27 15:37:35.326 *** alicE@localhost/res1 in <iq id='adcb274c7e7e9d3473e5655e6ec2ba8b' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>alicE@localhost/res1</jid> </bind> </iq>
*** User 2022-01-27 15:37:35.326 *** alicE@localhost/res1 out <iq type='set' id='bdcd903e9f12a6fd5add543e1d664a64'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:37:35.326 *** alicE@localhost/res1 in <iq type='result' id='bdcd903e9f12a6fd5add543e1d664a64'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:37:35.326 *** alicE@localhost/res1 out <presence/>
*** User 2022-01-27 15:37:35.327 *** alicE@localhost/res1 in <presence from='alicE@localhost/res1' to='alice@localhost/res1' xml:lang='en'/>
*** System report during websockets_SUITE:chat_msg/1 in wss_chat 2022-01-27 15:37:35.327 ***
=WARNING REPORT==== 27-Jan-2022::15:37:35.327800 ===
Description: "Authenticity is not established by certificate path validation"
Reason: "Option {verify, verify_peer} and cacertfile/cacerts is missing"
*** User 2022-01-27 15:37:35.334 *** geralt_s@localhost/res1 out <open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-01-27 15:37:35.335 *** geralt_s@localhost/res1 in <open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='a6e478bdf30205a3' from='localhost'/>
*** User 2022-01-27 15:37:35.335 *** geralt_s@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-01-27 15:37:35.335 *** geralt_s@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGdlcmFsdF9zAHdpdGNoZXJfcw==</auth>
*** User 2022-01-27 15:37:35.335 *** geralt_s@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:37:35.335 *** geralt_s@localhost/res1 out <open xmlns='urn:ietf:params:xml:ns:xmpp-framing' to='localhost' version='1.0'/>
*** User 2022-01-27 15:37:35.336 *** geralt_s@localhost/res1 in <open version='1.0' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing' id='dc3fede481dbe551' from='localhost'/>
*** User 2022-01-27 15:37:35.336 *** geralt_s@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-01-27 15:37:35.336 *** geralt_s@localhost/res1 out <iq type='set' id='fc7fcf9b874ceed45fd1a95c3dff02b7'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-27 15:37:35.336 *** geralt_s@localhost/res1 in <iq id='fc7fcf9b874ceed45fd1a95c3dff02b7' type='result' xmlns='jabber:client'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>geralt_s@localhost/res1</jid> </bind> </iq>
*** User 2022-01-27 15:37:35.336 *** geralt_s@localhost/res1 out <iq type='set' id='8ce87740125160924d811ec65309bc91'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:37:35.336 *** geralt_s@localhost/res1 in <iq type='result' id='8ce87740125160924d811ec65309bc91' xmlns='jabber:client'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:37:35.336 *** geralt_s@localhost/res1 out <presence/>
*** User 2022-01-27 15:37:35.337 *** geralt_s@localhost/res1 in <presence from='geralt_s@localhost/res1' to='geralt_s@localhost/res1' xmlns='jabber:client'/>
*** User 2022-01-27 15:37:35.337 *** 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-01-27 15:37:35.349 *** 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-01-27 15:37:35.349 *** 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-01-27 15:37:35.349 *** carol@localhost/res1 out <auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='PLAIN'>AGNhcm9sAGppbmdsZWJlbGxz</auth>
*** User 2022-01-27 15:37:35.350 *** carol@localhost/res1 in <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
*** User 2022-01-27 15:37:35.350 *** 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-01-27 15:37:35.361 *** 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-01-27 15:37:35.361 *** 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-01-27 15:37:35.361 *** carol@localhost/res1 out <iq type='set' id='aaae0698e09608884c13020da773fe81'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <resource>res1</resource> </bind> </iq>
*** User 2022-01-27 15:37:35.362 *** carol@localhost/res1 in <iq xmlns='jabber:client' id='aaae0698e09608884c13020da773fe81' type='result'> <bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'> <jid>carol@localhost/res1</jid> </bind> </iq>
*** User 2022-01-27 15:37:35.362 *** carol@localhost/res1 out <iq type='set' id='296261eb00bbe4a798378dd6dff50654'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:37:35.362 *** carol@localhost/res1 in <iq xmlns='jabber:client' type='result' id='296261eb00bbe4a798378dd6dff50654'> <session xmlns='urn:ietf:params:xml:ns:xmpp-session'/> </iq>
*** User 2022-01-27 15:37:35.362 *** carol@localhost/res1 out <presence/>
*** User 2022-01-27 15:37:35.363 *** carol@localhost/res1 in <presence xmlns='jabber:client' from='carol@localhost/res1' to='carol@localhost/res1' xml:lang='en'/>
*** User 2022-01-27 15:37:35.363 *** alicE@localhost/res1 out <message to='geralt_s@localhost/res1' type='chat'> <body>Hi!</body> </message>
*** User 2022-01-27 15:37:35.363 *** geralt_s@localhost/res1 in <message from='alicE@localhost/res1' to='geralt_s@localhost/res1' xml:lang='en' type='chat' xmlns='jabber:client'> <body>Hi!</body> </message>
*** User 2022-01-27 15:37:35.364 *** geralt_s@localhost/res1 out <message to='alicE@localhost/res1' type='chat'> <body>Hello!</body> </message>
*** User 2022-01-27 15:37:35.364 *** alicE@localhost/res1 in <message from='geralt_s@localhost/res1' to='alicE@localhost/res1' type='chat' xmlns='jabber:client'> <body>Hello!</body> </message>
*** User 2022-01-27 15:37:35.364 *** geralt_s@localhost/res1 out <message to='carol@localhost/res1' type='chat'> <body>Hey!</body> </message>
*** User 2022-01-27 15:37:35.365 *** carol@localhost/res1 in <message from='geralt_s@localhost/res1' to='carol@localhost/res1' type='chat' xmlns='jabber:client'> <body>Hey!</body> </message>
*** User 2022-01-27 15:37:35.365 *** carol@localhost/res1 out </stream:stream>
*** User 2022-01-27 15:37:35.365 *** carol@localhost/res1 in </stream:stream>
*** User 2022-01-27 15:37:35.365 *** geralt_s@localhost/res1 out <close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-01-27 15:37:35.366 *** geralt_s@localhost/res1 in <close xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
*** User 2022-01-27 15:37:35.366 *** alicE@localhost/res1 out </stream:stream>
*** User 2022-01-27 15:37:35.366 *** alicE@localhost/res1 in </stream:stream>
*** System report during websockets_SUITE:chat_msg/1 in wss_chat 2022-01-27 15:37:35.366 ***
=WARNING REPORT==== 27-Jan-2022::15:37:35.366809 ===
Description: "Authenticity is not established by certificate path validation"
Reason: "Option {verify, verify_peer} and cacertfile/cacerts is missing"
*** System report during websockets_SUITE:chat_msg/1 in wss_chat 2022-01-27 15:37:35.372 ***
=ERROR REPORT==== 27-Jan-2022::15:37:35.372604 ===
** State machine <0.23594.1> terminating
** Last event = {cast,{ws_send,<0.23593.1>,
#Ref<0.3928786125.940834818.209802>,close}}
** When server state = {connected,
{state,<0.23593.1>,
{up,#Ref<0.3928786125.940834818.209791>},
"localhost",5285,<<"https">>,"localhost",5285,[],
#{protocols => [http],
tls_opts => [],transport => tls},
undefined,
{sslsocket,
{gen_tcp,#Port<0.5349>,tls_connection,undefined},
[<0.23618.1>,<0.23616.1>]},
gun_tls,true,
{ssl,ssl_closed,ssl_error},
gun_http,
{http_state,
{sslsocket,
{gen_tcp,#Port<0.5349>,tls_connection,undefined},
[<0.23618.1>,<0.23616.1>]},
gun_tls,#{},'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,1194}]},
{proc_lib,init_p_do_apply,3,[{file,"proc_lib.erl"},{line,226}]}]
*** System report during websockets_SUITE:chat_msg/1 in wss_chat 2022-01-27 15:37:35.373 ***
=CRASH REPORT==== 27-Jan-2022::15:37:35.373048 ===
crasher:
initial call: gun:init/1
pid: <0.23594.1>
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 1194)
ancestors: [gun_conns_sup,gun_sup,<0.1301.0>]
message_queue_len: 1
messages: [{'DOWN',#Ref<0.3928786125.940834818.209791>,process,
<0.23593.1>,normal}]
links: [<0.1303.0>]
dictionary: []
trap_exit: false
status: running
heap_size: 10958
stack_size: 29
reductions: 54031
neighbours:
*** System report during websockets_SUITE:chat_msg/1 in wss_chat 2022-01-27 15:37:35.373 ***
=SUPERVISOR REPORT==== 27-Jan-2022::15:37:35.373414 ===
supervisor: {local,gun_conns_sup}
errorContext: child_terminated
reason: {undef,
[{gun_http,ws_send,
[close,
{http_state,
{sslsocket,
{gen_tcp,#Port<0.5349>,tls_connection,undefined},
[<0.23618.1>,<0.23616.1>]},
gun_tls,#{},'HTTP/1.1',keepalive,<<>>,undefined,[],
head,
{0,0},
head},
#Ref<0.3928786125.940834818.209802>,<0.23593.1>,
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,1194}]},
{proc_lib,init_p_do_apply,3,
[{file,"proc_lib.erl"},{line,226}]}]}
offender: [{pid,<0.23594.1>},
{id,gun},
{mfargs,{gun,start_link,undefined}},
{restart_type,temporary},
{significant,false},
{shutdown,5000},
{child_type,worker}]
=== Ended at 2022-01-27 15:37:35 === successfully completed test case === === Returned value: ok
Test run history | Top level test index | Latest test result