Description

After upgrading from Kamailio 5.7 to 5.8, we encountered an issue where SIP messages fail to send over WSS, resulting in a 477 error.

The problem seems to be related to the addition of protocol validation logic in tcp_main.c: https://github.com/kamailio/kamailio/blob/master/src/core/tcp_main.c#L1747
4a40b16

a->parent->rcv.proto == proto

a->parent->rcv.proto is 6 (indicating WSS), while proto is 5 (indicating WS), causing the connection lookup to fail.

Removing this validation line resolves the issue, restoring the previous behavior where SIP messages are successfully sent over WSS.

INFO level Log Messages

Jan 17 00:07:08.948495 kamailio[3487903]: WARNING: [799a4e2e-5fdf-444a-8dab-b2ab554c4933] tm [../../core/forward.h:204]: msg_send_buffer(): TCP/TLS connection for WebSocket could not be found
Jan 17 00:07:08.948516 kamailio[3487903]: WARNING: [799a4e2e-5fdf-444a-8dab-b2ab554c4933] tm [t_fwd.c:1586]: t_send_branch(): sending request on branch 0 failed
Jan 17 00:07:08.948536 kamailio[3487903]: INFO: [799a4e2e-5fdf-444a-8dab-b2ab554c4933] sl [sl_funcs.c:420]: sl_reply_error(): message marked with delayed-reply flag

DEBUG Level Log Messages

Jan 17 00:15:03.377043 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.377102 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Allow-Events] type 39
Jan 17 00:15:03.377122 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:661]: parse_headers(): header field type 39, name=<Allow-Events>, body=<talk, hold, conference, refer>
Jan 17 00:15:03.377178 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Subscription-State] type 37
Jan 17 00:15:03.377196 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:661]: parse_headers(): header field type 37, name=<Subscription-State>, body=<terminated;reason=noresource>
Jan 17 00:15:03.377254 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Route] type 9
Jan 17 00:15:03.377274 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:661]: parse_headers(): header field type 9, name=<Route>, body=<<sip:1.1.1.1:9060;lr;received=sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797%3Btransport%3Dws>>
Jan 17 00:15:03.377331 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Supported] type 17
Jan 17 00:15:03.377349 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:661]: parse_headers(): header field type 17, name=<Supported>, body=<path, replaces>
Jan 17 00:15:03.377406 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Contact] type 7
Jan 17 00:15:03.377426 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:661]: parse_headers(): header field type 7, name=<Contact>, body=<sip:dialpadgw@example.com>
Jan 17 00:15:03.377483 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Content-Type] type 11
Jan 17 00:15:03.377501 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:661]: parse_headers(): header field type 11, name=<Content-Type>, body=<application/data>
Jan 17 00:15:03.377555 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Event] type 22
Jan 17 00:15:03.377575 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:661]: parse_headers(): header field type 22, name=<Event>, body=<message-summary>
Jan 17 00:15:03.377641 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:91]: get_hdr_field(): found end of header
Jan 17 00:15:03.377698 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/pvapi.c:1450]: pv_printf_mode(): final buffer length 115
Jan 17 00:15:03.377716 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] 373:route[0]: <sip:1.1.1.1:9060;lr;received=sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797%3Btransport%3Dws>
Jan 17 00:15:03.377736 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.377754 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] pv [pv_core.c:1971]: pv_get_hdr_helper(): index out of range
Jan 17 00:15:03.377773 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/pvapi.c:1450]: pv_printf_mode(): final buffer length 17
Jan 17 00:15:03.377793 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] 374:route[1]: <null>
Jan 17 00:15:03.377812 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.377832 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.377849 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Supported] type 17
Jan 17 00:15:03.377867 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [X-carrier] type 0
Jan 17 00:15:03.377887 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.377905 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Max-Forwards] type 8
Jan 17 00:15:03.377924 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [X-FS-Support] type 0
Jan 17 00:15:03.377943 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Allow-Events] type 39
Jan 17 00:15:03.377962 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [X-FS-Support] type 0
Jan 17 00:15:03.377982 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [Content-Type] type 11
Jan 17 00:15:03.378001 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_hname2.c:314]: parse_sip_header_name(): parsed header name [X-FS-Support] type 0
Jan 17 00:15:03.378020 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.378038 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.378056 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.378076 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.378096 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.378115 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.378174 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.378194 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.378327 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=200
Jan 17 00:15:03.378383 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/pvapi.c:1450]: pv_printf_mode(): final buffer length 117
Jan 17 00:15:03.378403 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] 387:Route-URI is: sip:1.1.1.1:9060;lr;received=sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797%3Btransport%3Dws
Jan 17 00:15:03.378422 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] pv [pv_core.c:1343]: pv_get_dsturi(): no destination URI
Jan 17 00:15:03.378442 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_lookup.c:1565]: t_check_msg(): msg (0x7f845f8bc2c0) id=3/3519371 global id=2/3519371 T start=0xffffffffffffffff
Jan 17 00:15:03.378461 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.378479 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=78
Jan 17 00:15:03.378499 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_lookup.c:781]: t_lookup_request(): start searching: hash=32072, isACK=0
Jan 17 00:15:03.378517 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_lookup.c:499]: matching_3261(): RFC3261 transaction matching failed - via branch [z9hG4bK84d7.eabb4795000000000000000000000000.0]
Jan 17 00:15:03.378537 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_lookup.c:981]: t_lookup_request(): no transaction found
Jan 17 00:15:03.378555 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_lookup.c:1637]: t_check_msg(): msg (0x7f845f8bc2c0) id=3/3519371 global id=3/3519371 T end=(nil)
Jan 17 00:15:03.378572 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1326]: parse_uri(): state=5
Jan 17 00:15:03.378589 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1327]: parse_uri(): parsed uri:#012 type=1 user=<+11234567890-1234>(52)#012 passwd=<>(0)#012 host=<example.com>(22)#012 port=<>(0): 0#012 params=<>(0)#012 headers=<>(0)
Jan 17 00:15:03.378607 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1336]: parse_uri():  uri flags : 
Jan 17 00:15:03.378634 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1341]: parse_uri():    value=0
Jan 17 00:15:03.378655 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1342]: parse_uri():  uri params:#012   transport=<>, val=<>, proto=0
Jan 17 00:15:03.378672 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1345]: parse_uri():    user-param=<>, val=<>
Jan 17 00:15:03.378691 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1348]: parse_uri():    method=<>, val=<>
Jan 17 00:15:03.378711 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1350]: parse_uri():    ttl=<>, val=<>
Jan 17 00:15:03.378730 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1352]: parse_uri():    maddr=<>, val=<>
Jan 17 00:15:03.379547 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1354]: parse_uri():    lr=<>
Jan 17 00:15:03.379584 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1355]: parse_uri():    r2=<>
Jan 17 00:15:03.379759 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] siputils [checks.c:122]: has_totag(): no totag
Jan 17 00:15:03.379779 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=200
Jan 17 00:15:03.379799 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] rr [loose.c:80]: is_preloaded(): is_preloaded: Yes
Jan 17 00:15:03.379817 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1326]: parse_uri(): state=10
Jan 17 00:15:03.379835 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1327]: parse_uri(): parsed uri:#012 type=1 user=<>(0)#012 passwd=<>(0)#012 host=<1.1.1.1>(13)#012 port=<9060>(4): 9060#012 params=<lr;received=sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797%3Btransport%3Dws>(79)#012 headers=<>(0)
Jan 17 00:15:03.379856 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1336]: parse_uri():  uri flags : 
Jan 17 00:15:03.379874 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1341]: parse_uri():    value=0
Jan 17 00:15:03.379892 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1342]: parse_uri():  uri params:#012   transport=<>, val=<>, proto=0
Jan 17 00:15:03.379913 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1345]: parse_uri():    user-param=<>, val=<>
Jan 17 00:15:03.379931 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1348]: parse_uri():    method=<>, val=<>
Jan 17 00:15:03.379950 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1350]: parse_uri():    ttl=<>, val=<>
Jan 17 00:15:03.379969 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1352]: parse_uri():    maddr=<>, val=<>
Jan 17 00:15:03.379987 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1354]: parse_uri():    lr=<lr>
Jan 17 00:15:03.380007 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1355]: parse_uri():    r2=<>
Jan 17 00:15:03.380025 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/socket_info.c:737]: grep_sock_info(): checking if host==us: 13==11 && [1.1.1.1] == [10.128.0.35]
Jan 17 00:15:03.380044 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/socket_info.c:741]: grep_sock_info(): checking if port 9060 (advertise 9060) matches port 9060
Jan 17 00:15:03.380064 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/socket_info.c:763]: grep_sock_info(): checking advertise if host==us: 13==13 && [1.1.1.1] == [1.1.1.1]
Jan 17 00:15:03.380081 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/forward.c:446]: check_self(): host (0:1.1.1.1:9060) == me
Jan 17 00:15:03.380173 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] rr [loose.c:886]: after_loose(): Topmost route URI: 'sip:1.1.1.1:9060;lr;received=sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797%3Btransport%3Dws' is me
Jan 17 00:15:03.380238 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=200
Jan 17 00:15:03.380295 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:91]: get_hdr_field(): found end of header
Jan 17 00:15:03.380351 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] rr [loose.c:181]: find_next_route(): No next Route HF found
Jan 17 00:15:03.380379 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] rr [loose.c:916]: after_loose(): No next URI found
Jan 17 00:15:03.380398 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] rr [rr_cb.c:94]: run_rr_callbacks(): callback id 1 entered with <lr;received=sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797%3Btransport%3Dws>
Jan 17 00:15:03.380415 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] uac [replace.c:567]: restore_uri(): getting 'vsf' Route param
Jan 17 00:15:03.380435 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] uac [replace.c:570]: restore_uri(): route param 'vsf' not found
Jan 17 00:15:03.380453 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] uac [replace.c:567]: restore_uri(): getting 'vst' Route param
Jan 17 00:15:03.380473 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] uac [replace.c:570]: restore_uri(): route param 'vst' not found
Jan 17 00:15:03.380491 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] rr [rr_cb.c:94]: run_rr_callbacks(): callback id 0 entered with <lr;received=sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797%3Btransport%3Dws>
Jan 17 00:15:03.380584 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/strutils.c:207]: unescape_user(): unescaped string is <sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797;transport=ws>
Jan 17 00:15:03.380602 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] path [path.c:504]: path_rr_callback(): setting dst uri: sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797;transport=ws
Jan 17 00:15:03.380768 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/pvapi.c:1450]: pv_printf_mode(): final buffer length 83
Jan 17 00:15:03.380786 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] 497:outbound proxy is: sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797;transport=ws
Jan 17 00:15:03.381032 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/pvapi.c:1450]: pv_printf_mode(): final buffer length 66
Jan 17 00:15:03.381049 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] 514:found target_ip from du: [2604:3d08:777a:61a0:601f:864:1234:1234]
Jan 17 00:15:03.383827 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/action.c:1477]: do_action(): setting send-socket to [tls:[2600:1900:4000:f7cd:0:f::]:443]
Jan 17 00:15:03.383849 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.383911 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.383931 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.383949 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.384006 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.384065 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/pvapi.c:1450]: pv_printf_mode(): final buffer length 22
Jan 17 00:15:03.384181 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1326]: parse_uri(): state=5
Jan 17 00:15:03.384206 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1327]: parse_uri(): parsed uri:#012 type=1 user=<dialpadgw>(9)#012 passwd=<>(0)#012 host=<example.com>(22)#012 port=<>(0): 0#012 params=<>(0)#012 headers=<>(0)
Jan 17 00:15:03.384225 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1336]: parse_uri():  uri flags : 
Jan 17 00:15:03.384244 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1341]: parse_uri():    value=0
Jan 17 00:15:03.384265 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1342]: parse_uri():  uri params:#012   transport=<>, val=<>, proto=0
Jan 17 00:15:03.384286 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1345]: parse_uri():    user-param=<>, val=<>
Jan 17 00:15:03.384304 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1348]: parse_uri():    method=<>, val=<>
Jan 17 00:15:03.384324 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1350]: parse_uri():    ttl=<>, val=<>
Jan 17 00:15:03.384344 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1352]: parse_uri():    maddr=<>, val=<>
Jan 17 00:15:03.384362 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1354]: parse_uri():    lr=<>
Jan 17 00:15:03.384401 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1355]: parse_uri():    r2=<>
Jan 17 00:15:03.384578 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/tcp_main.c:1714]: _tcpconn_find(): 0  port 0
Jan 17 00:15:03.384595 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/pvapi.c:1450]: pv_printf_mode(): final buffer length 95
Jan 17 00:15:03.384612 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] 1168:<==== Relaying to sip:[2604:3d08:777a:61a0:601f:864:1234:1234]:52797;transport=ws conid=<null>
Jan 17 00:15:03.384630 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_lookup.c:1868]: t_newtran(): msg (0x7f845f8bc2c0) id=3/3519371 global id=3/3519371 T start=(nil)
Jan 17 00:15:03.384648 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.384666 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=78
Jan 17 00:15:03.384682 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_lookup.c:781]: t_lookup_request(): start searching: hash=32072, isACK=0
Jan 17 00:15:03.384701 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_lookup.c:499]: matching_3261(): RFC3261 transaction matching failed - via branch [z9hG4bK84d7.eabb4795000000000000000000000000.0]
Jan 17 00:15:03.384717 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_lookup.c:981]: t_lookup_request(): no transaction found
Jan 17 00:15:03.384733 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1326]: parse_uri(): state=65
Jan 17 00:15:03.384751 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1327]: parse_uri(): parsed uri:#012 type=1 user=<36k22ler>(8)#012 passwd=<>(0)#012 host=<f6sbiii372li.invalid>(20)#012 port=<>(0): 0#012 params=<transport=ws>(12)#012 headers=<>(0)
Jan 17 00:15:03.384768 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1336]: parse_uri():  uri flags : 
Jan 17 00:15:03.384793 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1341]: parse_uri():    value=0
Jan 17 00:15:03.384812 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1342]: parse_uri():  uri params:#012   transport=<transport=ws>, val=<ws>, proto=5
Jan 17 00:15:03.384828 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1345]: parse_uri():    user-param=<>, val=<>
Jan 17 00:15:03.384848 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1348]: parse_uri():    method=<>, val=<>
Jan 17 00:15:03.384868 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1350]: parse_uri():    ttl=<>, val=<>
Jan 17 00:15:03.384886 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1352]: parse_uri():    maddr=<>, val=<>
Jan 17 00:15:03.384907 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1354]: parse_uri():    lr=<>
Jan 17 00:15:03.384925 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1355]: parse_uri():    r2=<>
Jan 17 00:15:03.385025 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=78
Jan 17 00:15:03.385045 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/crypto/md5utils.c:67]: MD5StringArray(): MD5 calculated: 6e9568ded8dde3ef89a05a4f03829dc5
Jan 17 00:15:03.385065 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [h_table.c:415]: build_cell(): created new cell 0x7f8424c15380
Jan 17 00:15:03.385084 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [h_table.h:549]: insert_into_hash_table_unsafe(): cell label: 1965846678
Jan 17 00:15:03.385457 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1326]: parse_uri(): state=65
Jan 17 00:15:03.385476 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1327]: parse_uri(): parsed uri:#012 type=1 user=<>(0)#012 passwd=<>(0)#012 host=<[2604:3d08:777a:61a0:601f:864:1234:1234]>(40)#012 port=<52797>(5): 52797#012 params=<transport=ws>(12)#012 headers=<>(0)
Jan 17 00:15:03.385496 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1336]: parse_uri():  uri flags : 
Jan 17 00:15:03.385515 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1341]: parse_uri():    value=0
Jan 17 00:15:03.385534 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1342]: parse_uri():  uri params:#012   transport=<transport=ws>, val=<ws>, proto=5
Jan 17 00:15:03.385553 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1345]: parse_uri():    user-param=<>, val=<>
Jan 17 00:15:03.385571 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1348]: parse_uri():    method=<>, val=<>
Jan 17 00:15:03.385591 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1350]: parse_uri():    ttl=<>, val=<>
Jan 17 00:15:03.385608 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1352]: parse_uri():    maddr=<>, val=<>
Jan 17 00:15:03.385628 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1354]: parse_uri():    lr=<>
Jan 17 00:15:03.385649 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/parse_uri.c:1355]: parse_uri():    r2=<>
Jan 17 00:15:03.385668 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/msg_translator.c:1845]: check_boundaries(): no multi-part body
Jan 17 00:15:03.385772 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/tcp_main.c:1714]: _tcpconn_find(): 0  port 52797
Jan 17 00:15:03.385792 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/ip_addr.c:580]: print_ip(): tcpconn_find: ip 2604:3d08:777a:61a0:601f:864:1234:1234
Jan 17 00:15:03.385812 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/tcp_main.c:1735]: _tcpconn_find(): a=0x7f8424c013a0, c=0x7f8424c01150, c->id=1, alias port= 52797 port=52797
Jan 17 00:15:03.385830 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/ip_addr.c:580]: print_ip(): ip=2604:3d08:777a:61a0:601f:864:1234:1234
Jan 17 00:15:03.385850 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/tcp_main.c:1746]: _tcpconn_find(): found connection by peer address (id: 1)
Jan 17 00:15:03.385869 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/msg_translator.c:162]: check_via_address(): (1.1.1.1, 1.1.1.1, 0)
Jan 17 00:15:03.386610 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/tcp_main.c:1714]: _tcpconn_find(): 0  port 52797
Jan 17 00:15:03.386628 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/ip_addr.c:580]: print_ip(): tcpconn_find: ip 2604:3d08:777a:61a0:601f:864:1234:1234
Jan 17 00:15:03.386648 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/tcp_main.c:1735]: _tcpconn_find(): a=0x7f8424c013a0, c=0x7f8424c01150, c->id=1, alias port= 52797 port=52797
Jan 17 00:15:03.386666 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/ip_addr.c:580]: print_ip(): ip=2604:3d08:777a:61a0:601f:864:1234:1234
Jan 17 00:15:03.386685 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/tcp_main.c:1714]: _tcpconn_find(): 0  port 52797
Jan 17 00:15:03.386707 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/ip_addr.c:580]: print_ip(): tcpconn_find: ip 2604:3d08:777a:61a0:601f:864:1234:1234
Jan 17 00:15:03.386726 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/tcp_main.c:1735]: _tcpconn_find(): a=0x7f8424c01380, c=0x7f8424c01150, c->id=1, alias port= 52797 port=52797
Jan 17 00:15:03.386747 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/ip_addr.c:580]: print_ip(): ip=2604:3d08:777a:61a0:601f:864:1234:1234
Jan 17 00:15:03.386766 kamailio[3519371]: WARNING: [61e5f40c-acba-471f-94be-e66334eb217d] tm [../../core/forward.h:204]: msg_send_buffer(): TCP/TLS connection for WebSocket could not be found
Jan 17 00:15:03.386786 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_fwd.c:1566]: t_send_branch(): send to 2604:3d08:777a:61a0:601f:864:1234:1234:52797 (5) failed
Jan 17 00:15:03.386805 kamailio[3519371]: WARNING: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_fwd.c:1586]: t_send_branch(): sending request on branch 0 failed
Jan 17 00:15:03.386825 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_funcs.c:358]: t_relay_to(): t_forward_nonack returned error -1 (-477)
Jan 17 00:15:03.386842 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_funcs.c:376]: t_relay_to(): -477 error reply generation delayed 
Jan 17 00:15:03.386862 kamailio[3519371]: INFO: [61e5f40c-acba-471f-94be-e66334eb217d] sl [sl_funcs.c:420]: sl_reply_error(): message marked with delayed-reply flag
Jan 17 00:15:03.386955 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/receive.c:531]: receive_msg(): request-route executed in: 3370 usec
Jan 17 00:15:03.386972 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_lookup.c:2032]: t_unref(): delayed error reply generation(-477)
Jan 17 00:15:03.386989 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/parser/msg_parser.c:324]: parse_headers(): flags=ffffffffffffffff
Jan 17 00:15:03.387008 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/msg_translator.c:162]: check_via_address(): (1.1.1.1, 1.1.1.1, 0)
Jan 17 00:15:03.387180 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_reply.c:1782]: cleanup_uac_timers(): RETR/FR timers reset
Jan 17 00:15:03.387198 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] siptrace [siptrace.c:2476]: siptrace_net_data_sent(): processing message mode 1
Jan 17 00:15:03.387217 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] siptrace [siptrace_hep.c:523]: pipport2su(): the port string is 9060
Jan 17 00:15:03.387236 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] siptrace [siptrace_hep.c:523]: pipport2su(): the port string is 8060
Jan 17 00:15:03.387331 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/proxy.c:267]: mk_proxy(): doing DNS lookup...
Jan 17 00:15:03.387512 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] siptrace [siptrace_hep.c:185]: trace_send_hep3_duplicate(): setting up the socket_info
Jan 17 00:15:03.388083 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_reply.c:634]: _reply_light(): reply sent out - buf=0x7f845f88e060: SIP/2.0 477 Unfortun... shmem=0x7f8424c1b010: SIP/2.0 477 Unfortun
Jan 17 00:15:03.388181 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_funcs.c:133]: put_on_wait(): put T [0x7f8424c15380] on wait
Jan 17 00:15:03.388330 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] tm [t_reply.c:650]: _reply_light(): finished
Jan 17 00:15:03.388390 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/usr_avp.c:654]: destroy_avp_list(): destroying list (nil)
Jan 17 00:15:03.388437 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/usr_avp.c:654]: destroy_avp_list(): destroying list (nil)
Jan 17 00:15:03.388483 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/usr_avp.c:654]: destroy_avp_list(): destroying list (nil)
Jan 17 00:15:03.388531 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/usr_avp.c:654]: destroy_avp_list(): destroying list (nil)
Jan 17 00:15:03.388578 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/usr_avp.c:654]: destroy_avp_list(): destroying list (nil)
Jan 17 00:15:03.388625 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/usr_avp.c:654]: destroy_avp_list(): destroying list (nil)
Jan 17 00:15:03.388675 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/xavp.c:630]: xavp_destroy_list(): destroying xavp list (nil)
Jan 17 00:15:03.388722 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/xavp.c:630]: xavp_destroy_list(): destroying xavp list (nil)
Jan 17 00:15:03.388782 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/xavp.c:630]: xavp_destroy_list(): destroying xavp list (nil)
Jan 17 00:15:03.388801 kamailio[3519371]: DEBUG: [61e5f40c-acba-471f-94be-e66334eb217d] <core> [core/receive.c:635]: receive_msg(): cleaning up

SIP Traffic

Test Scenario:

  1. A client connects to Kamailio over WSS on port 443 and sends a REGISTER request, successfully registering.
  2. Another SIP server attempts to send a NOTIFY request to the client via Kamailio.
Client                          Kamailio                          SIP Server
   |                                |                                  |
   |--- REGISTER (WSS:443) -------> |                                  |
   |                                |                                  |
   |<--- 200 OK (Registration) ---- |                                  |
   |                                |                                  |
   |                                | <-- NOTIFY (UDP) --------------  |
   |                                |                                  |
   |                                |                                  |
   |                                | --- 477 Error -----------------> |
   |                                | (Failed to send NOTIFY)          |
   |                                |                                  |
   |                                |                                  |

I replaced our Kamailio server domain in the SIP message with 'example.com'.
kamailio IP: 1.1.1.1
client IP:3.3.3.3

REGISTER sip:example.com SIP/2.0
Via: SIP/2.0/WSS hfotrcsa7jk0.invalid;branch=z9hG4bK769149
...
Contact: <sip:23ao5h15@hfotrcsa7jk0.invalid;transport=ws>;+sip.ice;reg-id=1;+sip.instance="<urn:uuid:35e6e004-4a78-4c5f-999c-be70dda68e1f>";expires=900
...
NOTIFY sip:23ao5h15@hfotrcsa7jk0.invalid;transport=ws SIP/2.0
Via: SIP/2.0/UDP 2.2.2.2:8060;branch=z9hG4bKa769.503729f6000000000000000000000000.0
To: <sip:+11234567890-1234@example.com>
From: <sip:mygw@example.com>;tag=5e6acf4bd0c73e10f5120f096b1fc95c-e0aa3a8f
User-Agent: kamailio (5.8.3 (x86_64/linux))
...
Route: <sip:1.1.1.1:9060;lr;received=sip:3.3.3.3:63549%3Btransport%3Dws>
...
SIP/2.0 477 Unfortunately error on sending to next hop occurred (477/TM)

Possible Solutions

https://github.com/kamailio/kamailio/blob/master/src/core/tcp_main.c#L1747

	&& (proto == PROTO_NONE || a->parent->rcv.proto == proto)) {

Removing this validation line resolves the issue, restoring the previous behavior where SIP messages are successfully sent over WSS.

Additional Information

# ./kamailio -v
version: kamailio 5.8.3 (x86_64/linux) 42401c
flags: , EXTRA_DEBUGUSE_TCP, USE_TLS, USE_SCTP, TLS_HOOKS, USE_RAW_SOCKS, DISABLE_NAGLE, USE_MCAST, DNS_IP_HACK, SHM_MMAP, PKG_MALLOC, MEM_JOIN_FREE, Q_MALLOC, F_MALLOC, TLSF_MALLOC, DBG_SR_MEMORY, USE_FUTEX, FAST_LOCK-ADAPTIVE_WAIT, USE_DNS_CACHE, USE_DNS_FAILOVER, USE_NAPTR, USE_DST_BLOCKLIST, HAVE_RESOLV_RES, TLS_PTHREAD_MUTEX_SHARED
ADAPTIVE_WAIT_LOOPS 1024, MAX_RECV_BUFFER_SIZE 262144, MAX_SEND_BUFFER_SIZE 262144, MAX_URI_SIZE 1024, BUF_SIZE 65535, DEFAULT PKG_SIZE 8MB
poll method support: poll, epoll_lt, epoll_et, sigio_rt, select.
id: 42401c 
compiled on 23:24:48 Jan 16 2025 with gcc 10.2.1

debian 11.11

# uname -a
Linux 5.10.0-33-cloud-amd64 #1 SMP Debian 5.10.226-1 (2024-10-03) x86_64 GNU/Linux


Reply to this email directly, view it on GitHub, or unsubscribe.
You are receiving this because you are subscribed to this thread.Message ID: <kamailio/kamailio/issues/4115@github.com>