[SR-Users] Dialog keep alive options are with error parsing headers

Daniel-Constantin Mierla miconda at gmail.com
Mon Oct 12 17:28:08 CEST 2015


Hello,

do you set extra headers parameter?

http://kamailio.org/docs/modules/stable/modules/dialog.html#idp83584

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 at gmail.com
> <mailto:joseseabra4 at gmail.com>>:
>
>     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 at 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 at XX.XX.XX.6] 
>     34(22654) DEBUG: <core> [parser/msg_parser.c:175]:
>     get_hdr_field(): DEBUG: to body [<sip:unknown at 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 <http://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 at XX.XX.XX.6] 
>     34(22654) DEBUG: <core> [parser/msg_parser.c:175]:
>     get_hdr_field(): DEBUG: to body [<sip:0035912832114 at 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 <http://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 at XX.XX.XX.6] 
>     34(22654) DEBUG: <core> [parser/msg_parser.c:175]:
>     get_hdr_field(): DEBUG: to body [<sip:0035912832114 at 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 at 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 at XX.XX.XX.6] 
>     34(22654) DEBUG: <core> [parser/msg_parser.c:175]:
>     get_hdr_field(): DEBUG: to body [<sip:unknown at 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 at 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 at XX.XX.XX.6] 
>     34(22654) DEBUG: <core> [parser/msg_parser.c:175]:
>     get_hdr_field(): DEBUG: to body [<sip:unknown at 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 <http://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 at XX.XX.XX.6] 
>     34(22654) DEBUG: <core> [parser/msg_parser.c:175]:
>     get_hdr_field(): DEBUG: to body [<sip:0035912832114 at 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 <http://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 at XX.XX.XX.6] 
>     34(22654) DEBUG: <core> [parser/msg_parser.c:175]:
>     get_hdr_field(): DEBUG: to body [<sip:0035912832114 at 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 at 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 at XX.XX.XX.6] 
>     34(22654) DEBUG: <core> [parser/msg_parser.c:175]:
>     get_hdr_field(): DEBUG: to body [<sip:unknown at 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 at XX.XX.XX.25:5060 SIP/2.0
>     Via: SIP/2.0/UDP
>     XX.XX.XX.6;branch=z9hG4bKa135.f3b51855000000000000000000000000.0
>     To: <sip:unknown at XX.XX.XX.6>;tag=ee01f902aad54d95a6ebe96869cb8c99
>     From:
>     <sip:0035912832114 at 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 at gmail.com <mailto:miconda at gmail.com>>:
>
>         Hello,
>
>         the patch from next commit:
>
>         https://github.com/kamailio/kamailio/commit/551a562eb799c903cda09599ff5d47366abf42c9
>
>         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 at gmail.com
>>         <mailto:joseseabra4 at gmail.com>>:
>>
>>             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 at 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=<sip:unknown at 62.28.197.25:5060
>>             <http://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 at 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 at 62.28.197.6] 
>>             37(1587) DEBUG: <core> [parser/msg_parser.c:175]:
>>             get_hdr_field(): DEBUG: to body [<sip:unknown at 62.28.197.6
>>             <mailto:sip%3Aunknown at 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 at 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 at 62.28.197.6] 
>>             37(1587) DEBUG: <core> [parser/msg_parser.c:175]:
>>             get_hdr_field(): DEBUG: to body [<sip:unknown at 62.28.197.6
>>             <mailto:sip%3Aunknown at 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 list
>>         sr-users at lists.sip-router.org
>>         <mailto:sr-users at lists.sip-router.org>
>>         http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>
>         -- 
>         Daniel-Constantin Mierla
>         http://twitter.com/#!/miconda <http://twitter.com/#%21/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 at lists.sip-router.org
>         <mailto:sr-users at lists.sip-router.org>
>         http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>
>
>
>
>     -- 
>     Cumprimentos
>     José Seabra
>
>
>
>
> -- 
> Cumprimentos
> José Seabra

-- 
Daniel-Constantin Mierla
http://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda
Book: SIP Routing With Kamailio - http://www.asipto.com

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20151012/013e733b/attachment.html>


More information about the sr-users mailing list