There is a Voicis at the end of the OPTIONS headers, which makes the
request invalid -- we need to track how it got there...
Cheers,
Daniel
On 07/10/15 18:23, José Seabra wrote:
Hello Daniel,
Do you have any suggestion how to resolve this issue?
Best Regards
José Seabra
2015-09-25 9:37 GMT+01:00 José Seabra <joseseabra4(a)gmail.com>om>:
Hello Daniel,
Once again thank you for your support.
Please check below the kamailio logs with your patch:
34(22654) DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP
Request:
34(22654) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method:
<OPTIONS>
34(22654) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri:
<sip:unknown@XX.XX.XX.25:5060>
34(22654) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg(): version:
<SIP/2.0>
34(22654) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bKa135.f3b51855000000000000000000000000.0>; state=16
34(22654) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of
header reached, state=5
34(22654) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
parse_headers: Via found, flags=2
34(22654) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
parse_headers: this is the first via
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=ee01f902aad54d95a6ebe96869cb8c99
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field():
DEBUG: get_hdr_field: <To> [64]; uri=[sip:unknown@XX.XX.XX.6]
34(22654) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field():
DEBUG: to body [<sip:unknown@XX.XX.XX.6>]
34(22654) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <0> <OPTIONS>
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=af3be7f0ca0e408fac220f5febc9e509
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: dialog [dlg_cseq.c:215]: dlg_cseq_msg_sent(): traking
cseq updates
34(22654) DEBUG: dialog [dlg_hash.c:671]: internal_get_dlg(): ref dlg
0x7fc69f8f0f28 with 1 -> 2
34(22654) DEBUG: dialog [dlg_hash.c:674]: internal_get_dlg(): dialog
callid='3178f921d05c4a05a03b77ffecf17e96' found on entry 740, dir=2
34(22654) DEBUG: dialog [dlg_cseq.c:233]: dlg_cseq_msg_sent(): request
not going downstream (2)
34(22654) DEBUG: dialog [dlg_hash.c:846]: dlg_unref(): unref dlg
0x7fc69f8f0f28 with 1 -> 1
34(22654) DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP
Request:
34(22654) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method:
<OPTIONS>
34(22654) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri:
<sip:10.92.30.20:5060>
34(22654) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg(): version:
<SIP/2.0>
34(22654) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bK475c.719b3903000000000000000000000000.0>; state=16
34(22654) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of
header reached, state=5
34(22654) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
parse_headers: Via found, flags=2
34(22654) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
parse_headers: this is the first via
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=af3be7f0ca0e408fac220f5febc9e509
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field():
DEBUG: get_hdr_field: <To> [70]; uri=[sip:0035912832114@XX.XX.XX.6]
34(22654) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field():
DEBUG: to body [<sip:0035912832114@XX.XX.XX.6>]
34(22654) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <28937> <OPTIONS>
34(22654) DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field():
DEBUG: get_hdr_body : content_length=0
34(22654) DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found
end of header
34(22654) DEBUG: topoh [topoh_mod.c:241]: th_prepare_msg(): no second via
in this message
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=ee01f902aad54d95a6ebe96869cb8c99
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: topoh [topoh_mod.c:398]: th_msg_sent(): the COOKIE is
[xxx]
34(22654) DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP
Request:
34(22654) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method:
<OPTIONS>
34(22654) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri:
<sip:10.92.30.20:5060>
34(22654) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg(): version:
<SIP/2.0>
34(22654) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bK475c.719b3903000000000000000000000000.0>; state=16
34(22654) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of
header reached, state=5
34(22654) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
parse_headers: Via found, flags=2
34(22654) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
parse_headers: this is the first via
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=af3be7f0ca0e408fac220f5febc9e509
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field():
DEBUG: get_hdr_field: <To> [70]; uri=[sip:0035912832114@XX.XX.XX.6]
34(22654) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field():
DEBUG: to body [<sip:0035912832114@XX.XX.XX.6>]
34(22654) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <28937> <OPTIONS>
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=ee01f902aad54d95a6ebe96869cb8c99
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: dialog [dlg_cseq.c:215]: dlg_cseq_msg_sent(): traking
cseq updates
34(22654) DEBUG: dialog [dlg_hash.c:671]: internal_get_dlg(): ref dlg
0x7fc69f8f0f28 with 1 -> 2
34(22654) DEBUG: dialog [dlg_hash.c:674]: internal_get_dlg(): dialog
callid='3178f921d05c4a05a03b77ffecf17e96' found on entry 740, dir=1
34(22654) DEBUG: dialog [dlg_cseq.c:241]: dlg_cseq_msg_sent(): no
transaction for request
34(22654) DEBUG: dialog [dlg_hash.c:846]: dlg_unref(): unref dlg
0x7fc69f8f0f28 with 1 -> 1
34(22654) DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP
Request:
34(22654) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method:
<BYE>
34(22654) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri:
<sip:unknown@XX.XX.XX.25:5060>
34(22654) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg(): version:
<SIP/2.0>
34(22654) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bKb135.7d842b44000000000000000000000000.0>; state=16
34(22654) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of
header reached, state=5
34(22654) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
parse_headers: Via found, flags=2
34(22654) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
parse_headers: this is the first via
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=ee01f902aad54d95a6ebe96869cb8c99
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field():
DEBUG: get_hdr_field: <To> [64]; uri=[sip:unknown@XX.XX.XX.6]
34(22654) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field():
DEBUG: to body [<sip:unknown@XX.XX.XX.6>]
34(22654) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <1> <BYE>
34(22654) DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field():
DEBUG: get_hdr_body : content_length=0
34(22654) DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found
end of header
34(22654) DEBUG: topoh [topoh_mod.c:241]: th_prepare_msg(): no second via
in this message
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=af3be7f0ca0e408fac220f5febc9e509
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: topoh [topoh_mod.c:398]: th_msg_sent(): the COOKIE is
[xxx]
34(22654) DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP
Request:
34(22654) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method:
<BYE>
34(22654) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri:
<sip:unknown@XX.XX.XX.25:5060>
34(22654) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg(): version:
<SIP/2.0>
34(22654) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bKb135.7d842b44000000000000000000000000.0>; state=16
34(22654) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of
header reached, state=5
34(22654) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
parse_headers: Via found, flags=2
34(22654) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
parse_headers: this is the first via
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=ee01f902aad54d95a6ebe96869cb8c99
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field():
DEBUG: get_hdr_field: <To> [64]; uri=[sip:unknown@XX.XX.XX.6]
34(22654) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field():
DEBUG: to body [<sip:unknown@XX.XX.XX.6>]
34(22654) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <1> <BYE>
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=af3be7f0ca0e408fac220f5febc9e509
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: dialog [dlg_cseq.c:215]: dlg_cseq_msg_sent(): traking
cseq updates
34(22654) DEBUG: dialog [dlg_hash.c:671]: internal_get_dlg(): ref dlg
0x7fc69f8f0f28 with 1 -> 2
34(22654) DEBUG: dialog [dlg_hash.c:674]: internal_get_dlg(): dialog
callid='3178f921d05c4a05a03b77ffecf17e96' found on entry 740, dir=2
34(22654) DEBUG: dialog [dlg_cseq.c:233]: dlg_cseq_msg_sent(): request
not going downstream (2)
34(22654) DEBUG: dialog [dlg_hash.c:846]: dlg_unref(): unref dlg
0x7fc69f8f0f28 with 1 -> 1
34(22654) DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP
Request:
34(22654) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method:
<BYE>
34(22654) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri:
<sip:10.92.30.20:5060>
34(22654) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg(): version:
<SIP/2.0>
34(22654) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bK185c.846af8c0000000000000000000000000.0>; state=16
34(22654) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of
header reached, state=5
34(22654) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
parse_headers: Via found, flags=2
34(22654) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
parse_headers: this is the first via
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=af3be7f0ca0e408fac220f5febc9e509
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field():
DEBUG: get_hdr_field: <To> [70]; uri=[sip:0035912832114@XX.XX.XX.6]
34(22654) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field():
DEBUG: to body [<sip:0035912832114@XX.XX.XX.6>]
34(22654) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <28939> <BYE>
34(22654) DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field():
DEBUG: get_hdr_body : content_length=0
34(22654) DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found
end of header
34(22654) DEBUG: topoh [topoh_mod.c:241]: th_prepare_msg(): no second via
in this message
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=ee01f902aad54d95a6ebe96869cb8c99
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: topoh [topoh_mod.c:398]: th_msg_sent(): the COOKIE is
[dlh]
34(22654) DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP
Request:
34(22654) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method:
<BYE>
34(22654) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri:
<sip:10.92.30.20:5060>
34(22654) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg(): version:
<SIP/2.0>
34(22654) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bK185c.846af8c0000000000000000000000000.0>; state=16
34(22654) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of
header reached, state=5
34(22654) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
parse_headers: Via found, flags=2
34(22654) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
parse_headers: this is the first via
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=af3be7f0ca0e408fac220f5febc9e509
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field():
DEBUG: get_hdr_field: <To> [70]; uri=[sip:0035912832114@XX.XX.XX.6]
34(22654) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field():
DEBUG: to body [<sip:0035912832114@XX.XX.XX.6>]
34(22654) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <28939> <BYE>
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=ee01f902aad54d95a6ebe96869cb8c99
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: dialog [dlg_cseq.c:215]: dlg_cseq_msg_sent(): traking
cseq updates
34(22654) DEBUG: dialog [dlg_hash.c:680]: internal_get_dlg(): no dialog
callid='!!:NIxmJglQN-vTNDR-Hgx5HPx5N42mH4spsPHpNAreJAl*' found
34(22654) DEBUG: dialog [dlg_hash.c:711]: get_dlg(): no dialog
callid='!!:NIxmJglQN-vTNDR-Hgx5HPx5N42mH4spsPHpNAreJAl*' found
34(22654) DEBUG: dialog [dlg_handlers.c:1085]: dlg_lookup_msg_dialog():
dlg with callid '!!:NIxmJglQN-vTNDR-Hgx5HPx5N42mH4spsPHpNAreJAl*' not found
34(22654) DEBUG: dialog [dlg_cseq.c:227]: dlg_cseq_msg_sent(): no dialog
for this request
34(22654) DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP
Request:
34(22654) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method:
<OPTIONS>
34(22654) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri:
<sip:unknown@XX.XX.XX.25:5060>
34(22654) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg(): version:
<SIP/2.0>
34(22654) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bKa135.f3b51855000000000000000000000000.0>; state=16
34(22654) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of
header reached, state=5
34(22654) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
parse_headers: Via found, flags=2
34(22654) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
parse_headers: this is the first via
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
DEBUG: add_param: tag=ee01f902aad54d95a6ebe96869cb8c99
34(22654) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
34(22654) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field():
DEBUG: get_hdr_field: <To> [64]; uri=[sip:unknown@XX.XX.XX.6]
34(22654) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field():
DEBUG: to body [<sip:unknown@XX.XX.XX.6>]
34(22654) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <0> <OPTIONS>
34(22654) DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field():
DEBUG: get_hdr_body : content_length=0
34(22654) ERROR: <core> [parser/msg_parser.c:96]: get_hdr_field(): ERROR:
get_hdr_field: bad header
34(22654) DEBUG: <core> [parser/msg_parser.c:280]: get_hdr_field():
get_hdr_field: error exit
34(22654) INFO: <core> [parser/msg_parser.c:338]: parse_headers(): ERROR:
bad header field [Voicis
]
34(22654) DEBUG: topoh [topoh_mod.c:233]: th_prepare_msg(): parsing
headers failed [[OPTIONS sip:unknown@XX.XX.XX.25:5060 SIP/2.0
Via: SIP/2.0/UDP
XX.XX.XX.6;branch=z9hG4bKa135.f3b51855000000000000000000000000.0
To: <sip:unknown@XX.XX.XX.6>;tag=ee01f902aad54d95a6ebe96869cb8c99
From: <sip:0035912832114@XX.XX.XX.6>;tag=af3be7f0ca0e408fac220f5febc9e509
CSeq: 0 OPTIONS
Call-ID: 3178f921d05c4a05a03b77ffecf17e96
Max-Forwards: 70
Content-Length: 0
Voicis
]]
Best Regads
José Seabra
2015-09-24 20:49 GMT+01:00 Daniel-Constantin Mierla < <miconda(a)gmail.com>
miconda(a)gmail.com>gt;:
Hello,
the patch from next commit:
https://github.com/kamailio/kamailio/commit/551a562eb799c903cda09599ff5d473…
and compile in your version to see the full message content.
Cheers,
Daniel
On 24/09/15 20:47, José Seabra wrote:
Adding more information to my issue, these errors only happens when I'm
using topoh module, seems that dialog keep alive options is not working
with topoh module, maybe its something related with topoh callid
encription.
Best regards
José Seabra
2015-09-24 15:24 GMT+01:00 José Seabra < <joseseabra4(a)gmail.com>
joseseabra4(a)gmail.com>gt;:
Hello there,
I'm using dialog module to send keep alive options to callee and caller
in order to detect if dialog still up, but when kamailio generates the
OPTION and parse it, gives the following errors:
[root@c4-compute02-srv1 kamailio]# 37(1587) DEBUG: dialog
[dlg_hash.c:614]: dlg_lookup(): ref dlg 0x7f89134c1d40 with 1 -> 3
37(1587) DEBUG: dialog [dlg_hash.c:616]: dlg_lookup(): dialog id=2210
found on entry 2350
37(1587) DEBUG: dialog [dlg_req_within.c:427]: dlg_send_ka(): sending
OPTIONS to caller
37(1587) DEBUG: tm [uac.c:249]: t_uac_prepare(): DEBUG:tm:t_uac:
next_hop=< <http://sip:unknown@62.28.197.25:5060>
sip:unknown@62.28.197.25:5060>
37(1587) DEBUG: <core> [dns_cache.c:3293]: dns_srv_sip_resolve():
(62.28.197.25, 0, 0), ip, ret=0
37(1587) DEBUG: tm [uac.c:150]: dlg2hash(): DEBUG: dlg2hash: 14692
37(1587) DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP
Request:
37(1587) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method:
<OPTIONS>
37(1587) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri:
<sip:unknown@62.28.197.25:5060>
37(1587) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():
version: <SIP/2.0>
37(1587) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bK4693.2af96e95000000000000000000000000.0>; state=16
37(1587) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of
header reached, state=5
37(1587) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
parse_headers: Via found, flags=2
37(1587) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
parse_headers: this is the first via
37(1587) DEBUG: <core> [parser/parse_addr_spec.c:172]:
parse_to_param(): DEBUG: add_param: tag=90d40279ee5745d8851aa989e6fadfc2
37(1587) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
37(1587) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field():
DEBUG: get_hdr_field: <To> [64]; uri=[sip:unknown@62.28.197.6]
37(1587) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field():
DEBUG: to body [< <sip%3Aunknown@62.28.197.6>sip:unknown@62.28.197.6>]
37(1587) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <0> <OPTIONS>
37(1587) DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field():
DEBUG: get_hdr_body : content_length=0
*37(1587) ERROR: <core> [parser/msg_parser.c:96]: get_hdr_field():
ERROR: get_hdr_field: bad header*
37(1587) DEBUG: <core> [parser/msg_parser.c:280]: get_hdr_field():
get_hdr_field: error exit
*37(1587) INFO: <core> [parser/msg_parser.c:338]: parse_headers():
ERROR: bad header field [VC*
*]*
37(1587) DEBUG: topoh [topoh_mod.c:232]: th_prepare_msg(): parsing
headers failed37(1587) DEBUG: <core> [parser/msg_parser.c:606]:
parse_msg(): SIP Request:
37(1587) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method:
<OPTIONS>
37(1587) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri:
<sip:unknown@62.28.197.25:5060>
37(1587) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():
version: <SIP/2.0>
37(1587) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bK4693.2af96e95000000000000000000000000.0>; state=16
37(1587) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of
header reached, state=5
37(1587) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
parse_headers: Via found, flags=2
37(1587) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
parse_headers: this is the first via
37(1587) DEBUG: <core> [parser/parse_addr_spec.c:172]:
parse_to_param(): DEBUG: add_param: tag=90d40279ee5745d8851aa989e6fadfc2
37(1587) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
37(1587) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field():
DEBUG: get_hdr_field: <To> [64]; uri=[sip:unknown@62.28.197.6]
37(1587) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field():
DEBUG: to body [< <sip%3Aunknown@62.28.197.6>sip:unknown@62.28.197.6>]
37(1587) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <0> <OPTIONS>
37(1587) DEBUG: <core> [parser/parse_addr_spec.c:172]:
parse_to_param(): DEBUG: add_param: tag=e34d43e164ad4b7392dc9c6e1058a983
37(1587) DEBUG: <core> [parser/parse_addr_spec.c:894]:
parse_addr_spec(): end of header reached, state=29
37(1587) DEBUG: dialog [dlg_cseq.c:215]: dlg_cseq_msg_sent(): traking
cseq updates
37(1587) DEBUG: dialog [dlg_hash.c:671]: internal_get_dlg(): ref dlg
0x7f89134c1d40 with 1 -> 4
37(1587) DEBUG: dialog [dlg_hash.c:674]: internal_get_dlg(): dialog
callid='13208317017c42128fbf00e1685ee1b3' found on entry 2350, dir=2
37(1587) DEBUG: dialog [dlg_cseq.c:233]: dlg_cseq_msg_sent(): request
not going downstream (2)
37(1587) DEBUG: dialog [dlg_hash.c:846]: dlg_unref(): unref dlg
0x7f89134c1d40 with 1 -> 3
37(1587) DEBUG: dialog [dlg_req_within.c:452]: dlg_send_ka():
keep-alive sent to caller
37(1587) DEBUG: dialog [dlg_req_within.c:427]: dlg_send_ka(): sending
OPTIONS to callee
I'm using the following dialog configuration:
modparam("dialog","db_url", DBURL)
modparam("dialog","db_mode", 0)
modparam("dialog","enable_stats", 1)
modparam("dialog","dlg_flag", DLG_FLAG)
modparam("dialog","profiles_with_value","concurrentcalls")
modparam("dialog", "detect_spirals", 1)
modparam("dialog","dlg_match_mode", 2)
modparam("dialog", "initial_cbs_inscript", 0)
modparam("dialog", "default_timeout", 3600)
modparam("dialog", "send_bye", 1)
modparam("dialog", "timeout_avp", "$avp(s:timeout_dlg)")
modparam("dialog", "track_cseq_updates", 1)
modparam("dialog", "ka_timer", 10)
modparam("dialog", "ka_interval", 30)
I'm also using topoh module.
Anyone can help me to identify if I'm doing the proper configuration?
Thank you for your support
Best Regards
José Seabra
--
Cumprimentos
José Seabra
_______________________________________________
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing
listsr-users@lists.sip-router.orghttp://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
--
Daniel-Constantin
Mierlahttp://twitter.com/#!/miconda -
http://www.linkedin.com/in/miconda
Book: SIP Routing With Kamailio -
http://www.asipto.com
Kamailio Advanced Training, Sep 28-30, 2015, in Berlin -
http://asipto.com/u/kat
_______________________________________________
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
sr-users(a)lists.sip-router.org
http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
--
Cumprimentos
José Seabra