[SR-Users] Kamailio consult CNAM server through SIP Subscribe.
José Seabra
joseseabra4 at gmail.com
Tue Jun 21 13:23:55 CEST 2016
Email with attatchement.
2016-06-21 12:22 GMT+01:00 José Seabra <joseseabra4 at gmail.com>:
> Hello,
> Thanks for the hint to use cherry-pick,
>
> After applying these two patches the issue seems to be fixed.
> Please find out the attachment with kamailio logs.
>
> Thank you for your help.
>
> Regards
> José
>
> 2016-06-21 10:41 GMT+01:00 Daniel-Constantin Mierla <miconda at gmail.com>:
>
>> Hello,
>>
>> you should cherry-pick them with git into the branch 4.4.
>>
>> Cheers,
>> Daniel
>>
>> On 21/06/16 11:04, José Seabra wrote:
>>
>> Hi Daniel,
>> I have applied your last two patchs on tm module but i can't compile the
>> module because kemi framwork.
>>
>> I'm using kamailio version 4.4.
>>
>> Compile Errors:
>>
>> t_fwd.c:61:24: error: ../../kemi.h: No such file or directory
>> t_fwd.c: In function ‘prepare_new_uac’:
>> t_fwd.c:157: error: ‘sr_kemi_eng_t’ undeclared (first use in this
>> function)
>> t_fwd.c:157: error: (Each undeclared identifier is reported only once
>> t_fwd.c:157: error: for each function it appears in.)
>> t_fwd.c:157: error: ‘keng’ undeclared (first use in this function)
>> t_fwd.c:346: warning: implicit declaration of function ‘sr_kemi_eng_get’
>> t_fwd.c:348: warning: implicit declaration of function
>> ‘sr_kemi_act_ctx_get’
>> t_fwd.c:348: warning: assignment makes pointer from integer without a cast
>> t_fwd.c:350: warning: implicit declaration of function
>> ‘sr_kemi_act_ctx_set’
>> t_fwd.c:352: warning: implicit declaration of function
>> ‘sr_kemi_cbname_lookup_idx’
>> t_fwd.c: In function ‘add_blind_uac’:
>> t_fwd.c:715: error: ‘TM_UAC_FLAG_BLIND’ undeclared (first use in this
>> function)
>> make: *** [t_fwd.o] Error 1
>>
>> Regards
>> José
>>
>>
>> 2016-06-21 9:38 GMT+01:00 José Seabra <joseseabra4 at gmail.com>:
>>
>>> Hello Daniel,
>>>
>>> I confirm that the phone receives 200 OK to the CANCEL and 487 to the
>>> INVITE.
>>>
>>> I will backport the tm module to the last two patchs, then, after make
>>> all tests I will report back to you.
>>>
>>> Regards
>>> José
>>>
>>> 2016-06-21 5:33 GMT+01:00 Daniel-Constantin Mierla < <miconda at gmail.com>
>>> miconda at gmail.com>:
>>>
>>>> Can you try with master branch or backport the last two patches from tm
>>>> module? I pushed two commits that should catch and handle better this case.
>>>>
>>>> Cheers,
>>>> Daniel
>>>>
>>>> On 20/06/16 18:14, Daniel-Constantin Mierla wrote:
>>>>
>>>> Hello,
>>>>
>>>> it seems it tries to generate an outgoing cancel for the suspended
>>>> branch. I will check the code, likely there has to be added condition for
>>>> this cases.
>>>>
>>>> Is the 487 reply for invite sent back? Also, the 200ok for cancel?
>>>>
>>>> Cheers,
>>>> Daniel
>>>>
>>>> On 20/06/16 16:38, José Seabra wrote:
>>>>
>>>> Hello,
>>>>
>>>> I'm attaching more logs to this email regarding to the issue on SIP
>>>> CANCEL to an INVITE that is suspended.
>>>>
>>>> If do you think that i should open an issue on git regarding to this
>>>> let me know.
>>>>
>>>> Thank you for your help.
>>>>
>>>> Best Regards
>>>> José
>>>>
>>>> 2016-06-15 14:42 GMT+01:00 José Seabra < <joseseabra4 at gmail.com>
>>>> joseseabra4 at gmail.com>:
>>>>
>>>>> Hi Daniel,
>>>>>
>>>>> But when Kamailio receives a CANCEL prints the following error
>>>>> messages:
>>>>>
>>>>> 2016-06-15 14:39:10.354 ERROR: tm [t_msgbuilder.c:287]:
>>>>> build_local_reparse(): ERROR: build_local_reparse: INVITE is missing
>>>>> 2016-06-15 14:39:10.354 ERROR: tm [t_msgbuilder.c:494]:
>>>>> build_local_reparse(): ERROR: build_local_reparse: cannot build CANCEL
>>>>> request
>>>>> 2016-06-15 14:39:10.354 ERROR: tm [t_cancel.c:310]: cancel_branch():
>>>>> ERROR: attempt to build a CANCEL failed
>>>>> 2016-06-15 14:39:10.354 ERROR: tm [t_fwd.c:1389]: e2e_cancel():
>>>>> ERROR: cancel error
>>>>>
>>>>> I'm handling the CANCEL in the script by the following way:
>>>>>
>>>>>
>>>>> if (is_method("CANCEL")) {
>>>>> if (t_check_trans()) {
>>>>> route(RELAY);
>>>>> } else {
>>>>> sl_send_reply("481", "Call leg/transaction
>>>>> does not exist");
>>>>> }
>>>>> exit();
>>>>> ...
>>>>> ...
>>>>> ...
>>>>>
>>>>> Thank you for your support.
>>>>>
>>>>> Regards
>>>>> José
>>>>>
>>>>>
>>>>> 2016-06-15 12:15 GMT+01:00 Daniel-Constantin Mierla <
>>>>> <miconda at gmail.com>miconda at gmail.com>:
>>>>>
>>>>>> Hello,
>>>>>>
>>>>>> On 14/06/16 16:33, José Seabra wrote:
>>>>>>
>>>>>> Hi Olle and Daniel,
>>>>>> Thank you for your replies, After receive your msg I looked again to
>>>>>> my script and i found the problem.
>>>>>>
>>>>>> I didn't configure the correct failure_route block and the failure
>>>>>> route configured didn't print any msg on the logs, so I thought that
>>>>>> it wasn't entering on failure route.
>>>>>>
>>>>>> Sorry for my mistake.
>>>>>>
>>>>>> Anyway, How should i handle the CANCEL sip msg to an INVITE that is
>>>>>> suspended? (still related with this implementation)
>>>>>>
>>>>>> Just handling it as done in the default configuration file is ok --
>>>>>> the suspended transaction will be canceled.
>>>>>>
>>>>>> Cheers,
>>>>>> Daniel
>>>>>>
>>>>>
>>>> --
>>>> Daniel-Constantin Mierlahttp://www.asipto.com - http://www.kamailio.orghttp://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda
>>>>
>>>>
>>>
>>>
>>> --
>>> Cumprimentos
>>> José Seabra
>>>
>>
>>
>>
>> --
>> Cumprimentos
>> José Seabra
>>
>>
>> --
>> Daniel-Constantin Mierlahttp://www.asipto.com - http://www.kamailio.orghttp://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda
>>
>>
>
>
> --
> Cumprimentos
> José Seabra
>
--
Cumprimentos
José Seabra
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20160621/b2c15eb0/attachment.html>
-------------- next part --------------
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [receive.c:221]: receive_msg(): preparing to run routing scripts...
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <750311> <CANCEL>
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=9PV_tw
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: sanity [mod_sanity.c:248]: w_sanity_check(): sanity checks result: 1
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 49
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tmx [tmx_pretran.c:219]: tmx_check_pretran(): no pre-transaction management for ACK or CANCEL
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} WARNING: <script>: ABC SOURCE - 10.112.185.128:5060 ID=VqT_vW5XY2B6A0xuYa7mmQ
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} INFO: <script>: New request - M=CANCEL R=sip:sec.abcsoft.503 at example.local F=sip:502 at example.local T=sip:sec.abcsoft.503 at example.local IP=udp:10.112.185.128:5060 ID=VqT_vW5XY2B6A0xuYa7mmQ
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: siputils [checks.c:97]: has_totag(): no totag
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:701]: t_lookupOriginalT(): DEBUG: t_lookupOriginalT: searching on hash entry 20684
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:409]: matching_3261(): DEBUG: RFC3261 transaction matched, tid=iz-kuh802broqT9YKBLjHg
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:798]: t_lookupOriginalT(): DEBUG: t_lookupOriginalT: canceled transaction found (0x7f744dfd09a8)!
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:801]: t_lookupOriginalT(): DEBUG: t_lookupOriginalT completed
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [tm.c:992]: w_t_lookup_cancel(): lookup_original: t_lookupOriginalT returned: 0x7f744dfd09a8
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:1312]: t_newtran(): DEBUG: t_newtran: msg id=9 , global msg id=8 , T on entrance=0xffffffffffffffff
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=20684, isACK=0
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_hooks.c:358]: run_reqin_callbacks_internal(): DBG: trans=0x7f744dfed4b8, callback type 1, id 0 entered
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [md5utils.c:67]: MD5StringArray(): MD5 calculated: 29f9b25910de6b835aee5e8cb41de048
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:701]: t_lookupOriginalT(): DEBUG: t_lookupOriginalT: searching on hash entry 20684
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:409]: matching_3261(): DEBUG: RFC3261 transaction matched, tid=iz-kuh802broqT9YKBLjHg
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:798]: t_lookupOriginalT(): DEBUG: t_lookupOriginalT: canceled transaction found (0x7f744dfd09a8)!
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_lookup.c:801]: t_lookupOriginalT(): DEBUG: t_lookupOriginalT completed
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_reply.c:1592]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_reply.c:648]: _reply_light(): DEBUG: reply sent out. buf=0x7f7451b93610: SIP/2.0 487 Request ..., shmem=0x7f744dfd9b18: SIP/2.0 487 Request
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_reply.c:658]: _reply_light(): DEBUG: _reply_light: finished
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_fwd.c:1279]: e2e_cancel(): DEBUG: e2e_cancel: e2e cancel -- no active branches
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_reply.c:1592]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_reply.c:648]: _reply_light(): DEBUG: reply sent out. buf=0x7f7451b93610: SIP/2.0 200 ok -- no..., shmem=0x7f744dfe19c0: SIP/2.0 200 ok -- no
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_reply.c:658]: _reply_light(): DEBUG: _reply_light: finished
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tm [t_funcs.c:368]: t_relay_to(): SER: new transaction fwd'ed
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
2016-06-21 12:18:57.008 {1 CANCEL VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: <core> [receive.c:322]: receive_msg(): cleaning up
2016-06-21 12:18:57.013 {1 ACK VqT_vW5XY2B6A0xuYa7mmQ} DEBUG: tmx [tmx_pretran.c:219]: tmx_check_pretran(): no pre-transaction management for ACK or CANCEL
More information about the sr-users
mailing list