New subject: Unable to make SIP Calls (403 Forbidden - Domain Not Served)

1 Jun 2017

Hello All,
I am re-sending the issue with edited data;

I am newbie to kamailio.
I am trying to make call between two UAs(two different PCs with BOGHE 2.0
installed)
I am getting 403, domain not served. The setup is as below.

1) We are using Kamailio-5.0 and installed for IMS.
2) Using Boghe 2.0 for SIP Clients.
3) We have installed p-cscf, i-cscf, s-cscf and HSS(FHoss) in same PC.
4) Able to register Alice and Bob.
5) When we make call From Alice to Bob:
    Step a) INVITE is passed successfully to ALICE -> p-cscf.
        Step b) p-cscf -> s-cscf
    Step c) s-cscf -> i-cscf
        Step d) i-cscf -> s-cscf

I have provided SIP/DIAMETER transactions below for greater clarity.

In Step d)  after receiving INVITE message the s-cscf should refer the
bob's register information and forward
the INVITE to p-cscf server and to UE(Bob).

It appears to me from scscf console output (partially shown below): because
of same call-id as it previously registered INVITE and this doesn't have TO
tag to it,
the INVITE is being dropped, instead of forwarding to p-cscf server. How do
i address this issue?

I am assuming we can make calls to UEs connected same domain and three
servers(p,i, s cscf servers) and hss running in same PC.
Kindly clarify my error from the inputs i have provided. Also kindly
suggest any relevant/doc to address above issue.

Upon required i will send  cfg/wireshark files.

I am early waiting for your response.

Thanking you,
Regards
Prasanna

//-------------------------------------------------------------------
*********************FROM ALICE TO P-SERVER**************************
*********************************************************************
Internet Protocol Version 4, Src: 192.168.99.145 (192.168.99.145), Dst:
192.168.99.140 (192.168.99.140)
User Datagram Protocol, Src Port: 64291 (64291), Dst Port: 5060 (5060)

Session Initiation Protocol (INVITE)
INVITE sip:bob@koffee-ims.in SIP/2.0
Via: SIP/2.0/UDP 192.168.99.145:64291;branch=z9hG4bK11207255;rport
From: <sip:alice@koffee-ims.in>;tag=11216074
To: <sip:bob@koffee-ims.in>
Contact: <sip:alice@192.168.99.145:64291
;transport=udp>;+g.oma.sip-im;language="en,fr";+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel"
Call-ID: 6447fbad-2151-4250-dfc9-44536257cb88
CSeq: 18274 INVITE
Content-Type: application/sdp
Content-Length: 517
Max-Forwards: 70
Route: <sip:orig@scscf.koffee-ims.in;lr>
Accept-Contact:
*;+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel"
P-Preferred-Service: urn:urn-7:3gpp-service.ims.icsi.mmtel
Allow: INVITE, ACK, CANCEL, BYE, MESSAGE, OPTIONS, NOTIFY, PRACK, UPDATE,
REFER
Privacy: none
P-Access-Network-Info: ADSL;utran-cell-id-3gpp=00000000
User-Agent: IM-client/OMA1.0 Boghe-Win32/v2.0.153.836
P-Preferred-Identity: <sip:alice@koffee-ims.in>
Supported: 100rel
//-------------------------------------------------------------------
//-------------------------------------------------------------------
*********************FROM P-SERVER TO S-SERVER***********************
*********************************************************************
User Datagram Protocol, Src Port: 5060 (5060), Dst Port: 6060 (6060)

INVITE sip:bob@koffee-ims.in SIP/2.0
Record-Route: <sip:mo@192.168.99.140;lr=on;ftag=11216074;rm=8>
Via: SIP/2.0/UDP
192.168.99.140;branch=z9hG4bK9a2d.5a4f00d2df50a845fd19195409528b5d.0
Via: SIP/2.0/UDP 192.168.99.145:64291
;received=192.168.99.145;branch=z9hG4bK11207255;rport=64291
From: <sip:alice@koffee-ims.in>;tag=11216074
To: <sip:bob@koffee-ims.in>
Contact: <sip:alice@192.168.99.145:64291
;transport=udp>;+g.oma.sip-im;language="en,fr";+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel"
Call-ID: 6447fbad-2151-4250-dfc9-44536257cb88
CSeq: 18274 INVITE
Content-Type: application/sdp
Content-Length: 531
Max-Forwards: 69
Route: <sip:orig@scscf.koffee-ims.in;lr>
Accept-Contact:
*;+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel"
P-Preferred-Service: urn:urn-7:3gpp-service.ims.icsi.mmtel
Allow: INVITE, ACK, CANCEL, BYE, MESSAGE, OPTIONS, NOTIFY, PRACK, UPDATE,
REFER
Privacy: none
P-Access-Network-Info: ADSL;utran-cell-id-3gpp=00000000
User-Agent: IM-client/OMA1.0 Boghe-Win32/v2.0.153.836
Supported: 100rel
P-Charging-Vector: icid-value=4956537F000101DE0B00004E00000000;
icid-generated-at=192.168.99.140
P-Asserted-Identity: <sip:alice@koffee-ims.in>
P-Visited-Network-ID: koffee-ims.in
//-------------------------------------------------------------------
*********************FROM S-SERVER TO I-SERVER***********************
*********************************************************************
User Datagram Protocol, Src Port: 6060 (6060), Dst Port: 4060 (4060)

INVITE sip:bob@koffee-ims.in SIP/2.0
Record-Route: <sip:mo@192.168.99.140:6060;lr=on;ftag=11216074;did=7b.c3d1>
Record-Route: <sip:mo@192.168.99.140;lr=on;ftag=11216074;rm=8>
Via: SIP/2.0/UDP 192.168.99.140:6060
;branch=z9hG4bK9a2d.ef3a8302086279e3b26ed0037e57be05.0
Via: SIP/2.0/UDP
192.168.99.140;branch=z9hG4bK9a2d.5a4f00d2df50a845fd19195409528b5d.0
Via: SIP/2.0/UDP 192.168.99.145:64291
;received=192.168.99.145;branch=z9hG4bK11207255;rport=64291
From: <sip:alice@koffee-ims.in>;tag=11216074
To: <sip:bob@koffee-ims.in>
Contact: <sip:alice@192.168.99.145:64291
;transport=udp>;+g.oma.sip-im;language="en,fr";+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel"
Call-ID: 6447fbad-2151-4250-dfc9-44536257cb88
CSeq: 18274 INVITE
Content-Type: application/sdp
Content-Length: 531
Max-Forwards: 68
Accept-Contact:
*;+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel"
P-Preferred-Service: urn:urn-7:3gpp-service.ims.icsi.mmtel
Allow: INVITE, ACK, CANCEL, BYE, MESSAGE, OPTIONS, NOTIFY, PRACK, UPDATE,
REFER
Privacy: none
P-Access-Network-Info: ADSL;utran-cell-id-3gpp=00000000
User-Agent: IM-client/OMA1.0 Boghe-Win32/v2.0.153.836
Supported: 100rel
P-Charging-Vector: icid-value=4956537F000101DE0B00004E00000000;
icid-generated-at=192.168.99.140
P-Visited-Network-ID: koffee-ims.in
P-Asserted-Identity: <sip:alice@koffee-ims.in>

//--------------------------------------------------------------------
Diameter Request:
-----------------
AVP: Origin-Host(264) l=27 f=-M- val=icscf.koffee-ims.in
AVP: Origin-Realm(296) l=21 f=-M- val=koffee-ims.in
AVP: Vendor-Specific-Application-Id(260) l=32 f=-M-
AVP: Auth-Session-State(277) l=12 f=-M- val=NO_STATE_MAINTAINED (1)
AVP: Public-Identity(601) l=33 f=VM- vnd=TGPP val=sip:bob@koffee-ims.in

//--------------------------------------------------------------------
Diameter Reply:
-----------------

AVP: Session-Id(263) l=41 f=-M- val=icscf.koffee-ims.in;1832500942;13
AVP: Origin-Host(264) l=25 f=-M- val=hss.koffee-ims.in
AVP: Origin-Realm(296) l=21 f=-M- val=koffee-ims.in
AVP: Auth-Session-State(277) l=12 f=-M- val=NO_STATE_MAINTAINED (1)
AVP: Vendor-Specific-Application-Id(260) l=32 f=-M-
AVP: Server-Name(602) l=35 f=VM- vnd=TGPP val=sip:scscf.koffee-ims.in
AVP: Result-Code(268) l=12 f=-M- val=DIAMETER_SUCCESS (2001)

//-------------------------------------------------------------------
*********************FROM I-SERVER TO S-SERVER***********************
*********************************************************************
//--------------------------------------------------------------------
INVITE sip:bob@koffee-ims.in SIP/2.0
Route: <sip:scscf.koffee-ims.in>
Record-Route: <sip:mo@192.168.99.140:6060;lr=on;ftag=11216074;did=7b.c3d1>
Record-Route: <sip:mo@192.168.99.140;lr=on;ftag=11216074;rm=8>
Via: SIP/2.0/UDP 192.168.99.140:4060
;branch=z9hG4bK9a2d.d063e6afc4b4d46f1f10b1133f956b65.1
Via: SIP/2.0/UDP 192.168.99.140:6060
;branch=z9hG4bK9a2d.ef3a8302086279e3b26ed0037e57be05.0
Via: SIP/2.0/UDP
192.168.99.140;branch=z9hG4bK9a2d.5a4f00d2df50a845fd19195409528b5d.0
Via: SIP/2.0/UDP 192.168.99.145:64291
;received=192.168.99.145;branch=z9hG4bK11207255;rport=64291
From: <sip:alice@koffee-ims.in>;tag=11216074
To: <sip:bob@koffee-ims.in>
Contact: <sip:alice@192.168.99.145:64291
;transport=udp>;+g.oma.sip-im;language="en,fr";+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel"
Call-ID: 6447fbad-2151-4250-dfc9-44536257cb88
CSeq: 18274 INVITE
Content-Type: application/sdp
Content-Length: 531
Max-Forwards: 67
Accept-Contact:
*;+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel"
P-Preferred-Service: urn:urn-7:3gpp-service.ims.icsi.mmtel
Allow: INVITE, ACK, CANCEL, BYE, MESSAGE, OPTIONS, NOTIFY, PRACK, UPDATE,
REFER
Privacy: none
P-Access-Network-Info: ADSL;utran-cell-id-3gpp=00000000
User-Agent: IM-client/OMA1.0 Boghe-Win32/v2.0.153.836
Supported: 100rel
P-Charging-Vector: icid-value=4956537F000101DE0B00004E00000000;
icid-generated-at=192.168.99.140
P-Visited-Network-ID: koffee-ims.in
P-Asserted-Identity: <sip:alice@koffee-ims.in>
//-------------------------------------------------------------------
*********************FROM S-SERVER TO I-SERVER***********************
*********************************************************************
//--------------------------------------------------------------------
User Datagram Protocol, Src Port: 6060 (6060), Dst Port: 4060 (4060)

SIP/2.0 403 Forbidden - Domain not served
Via: SIP/2.0/UDP 192.168.99.140:4060
;branch=z9hG4bK9a2d.d063e6afc4b4d46f1f10b1133f956b65.1
Via: SIP/2.0/UDP 192.168.99.140:6060
;branch=z9hG4bK9a2d.ef3a8302086279e3b26ed0037e57be05.0
Via: SIP/2.0/UDP
192.168.99.140;branch=z9hG4bK9a2d.5a4f00d2df50a845fd19195409528b5d.0
Via: SIP/2.0/UDP 192.168.99.145:64291
;received=192.168.99.145;branch=z9hG4bK11207255;rport=64291
From: <sip:alice@koffee-ims.in>;tag=11216074
To: <sip:bob@koffee-ims.in>;tag=84772552fab76e8916cf9e5dd5027417.1f62
Call-ID: 6447fbad-2151-4250-dfc9-44536257cb88
CSeq: 18274 INVITE
Server:scscf1
Content-Length: 0

//------------------------------------------------------------------
********************************************************************
S-CSCF config output logs:
--------------------------
7(3205) DEBUG: <core> [core/parser/msg_parser.c:600]: parse_msg(): SIP
Request:
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:602]: parse_msg():
method:  <INVITE>
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:604]: parse_msg():
uri:     <sip:bob@koffee-ims.in>
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:606]: parse_msg():
version: <SIP/2.0>
 7(3205) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bK9a2d.d063e6afc4b4d46f1f10b1133f956b65.1>; state=16
 7(3205) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of
header reached, state=5
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:491]: parse_headers(): Via
found, flags=2
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:493]: parse_headers():
this is the first via
 7(3205) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bK9a2d.ef3a8302086279e3b26ed0037e57be05.0>; state=16
 7(3205) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of
header reached, state=5
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:491]: parse_headers(): Via
found, flags=78
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:504]: parse_headers():
this is the second via
 7(3205) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bK9a2d.5a4f00d2df50a845fd19195409528b5d.0>; state=16
 7(3205) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of
header reached, state=5
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:491]: parse_headers(): Via
found, flags=78
 7(3205) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param():
Found param type 234, <received> = <192.168.99.145>; state=6
 7(3205) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param():
Found param type 232, <branch> = <z9hG4bK11207255>; state=6
 7(3205) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param():
Found param type 235, <rport> = <64291>; state=16
 7(3205) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of
header reached, state=5
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:491]: parse_headers(): Via
found, flags=78
 7(3205) DEBUG: <core> [core/parser/parse_addr_spec.c:864]:
parse_addr_spec(): end of header reached, state=10
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field():
<To> [25]; uri=[sip:bob@koffee-ims.in]
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field(): to
body [<sip:bob@koffee-ims.in>
]
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field():
cseq <CSeq>: <18274> <INVITE>
 7(3205) DEBUG: <core> [core/receive.c:191]: receive_msg(): --- received
sip message - request - call-id: [6447fbad-2151-4250-dfc9-44536257cb88] -
cseq: [18274 INVITE]
 7(3205) DEBUG: <core> [core/receive.c:234]: receive_msg(): preparing to
run routing scripts...
 7(3205) ERROR: <script>: Inside route{........}
 7(3205) DEBUG: <script>: Mem: Total 67108864, Free 64506068 [1% used]
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:183]: get_hdr_field():
content_length=531
 7(3205) DEBUG: maxfwd [mf_funcs.c:76]: is_maxfwd_present(): value = 67
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field():
found end of header
 7(3205) DEBUG: <core> [core/parser/parse_addr_spec.c:185]:
parse_to_param(): add param: tag=11216074
 7(3205) DEBUG: <core> [core/parser/parse_addr_spec.c:864]:
parse_addr_spec(): end of header reached, state=29
 7(3205) DEBUG: sanity [sanity_mod.c:256]: w_sanity_check(): sanity checks
result: 1
 7(3205) DEBUG: siputils [checks.c:120]: has_totag(): no totag
 7(3205) DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT
0xb6d80e64
 7(3205) DEBUG: tm [t_lookup.c:1001]: t_check_msg(): msg id=8 global id=7 T
start=0xffffffff
 7(3205) DEBUG: tm [t_lookup.c:459]: t_lookup_request(): start searching:
hash=53929, isACK=0
 7(3205) DEBUG: tm [t_lookup.c:417]: matching_3261(): RFC3261 transaction
matching failed
 7(3205) DEBUG: tm [t_lookup.c:641]: t_lookup_request(): no transaction
found
 7(3205) DEBUG: tm [t_lookup.c:1070]: t_check_msg(): msg id=8 global id=8 T
end=(nil)
 7(3205) DEBUG: sl [sl.c:282]: send_reply(): reply in stateless mode (sl)
 7(3205) DEBUG: <core> [core/msg_translator.c:159]: check_via_address():
(192.168.99.140, 192.168.99.140, 1)
 7(3205) ERROR: <script>: SUBSCRIBE: setting flag time [Thu Jun  1 12:50:46
2017] )
 7(3205) DEBUG: rr [loose.c:85]: is_preloaded(): is_preloaded: Yes
 7(3205) DEBUG: <core> [core/socket_info.c:564]: grep_sock_info(): checking
if host==us: 19==14 && [scscf.koffee-ims.in] == [192.168.99.140]
 7(3205) DEBUG: <core> [core/socket_info.c:567]: grep_sock_info(): checking
if port 6060 (advertise 0) matches port 5060
 7(3205) DEBUG: rr [loose.c:788]: after_loose(): Topmost route URI: 'sip:
scscf.koffee-ims.in' is me
 7(3205) DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field():
found end of header
 7(3205) DEBUG: rr [loose.c:180]: find_next_route(): No next Route HF found
 7(3205) DEBUG: rr [loose.c:813]: after_loose(): No next URI found
 7(3205) ERROR: <script>: No=1 Before checking sip:orig@.*
 7(3205) DEBUG: ims_isc [mark.c:90]: isc_mark_get_from_msg():
isc_mark_get_from_msg: Trying to get the mark from the message
 7(3205) DEBUG: ims_isc [mark.c:90]: isc_mark_get_from_msg():
isc_mark_get_from_msg: Trying to get the mark from the message
 7(3205) ERROR: <script>: time [Thu Jun  1 12:50:46 2017] routeURI (sip:
scscf.koffee-ims.in) method (INVITE) r-uri (sip:bob@koffee-ims.in) 1st via
(<null>)
 7(3205) DEBUG: ims_dialog [dlg_profile.c:596]: is_dlg_in_profile():
Getting current dialog 7(3205) DEBUG: ims_dialog [dlg_hash.h:414]:
match_dialog(): No dlg outs yet...
 7(3205) DEBUG: ims_dialog [dlg_hash.c:915]: internal_get_dlg(): ref dlg
0xb200ac10 with 1 -> 2
 7(3205) DEBUG: ims_dialog [dlg_hash.c:918]: internal_get_dlg(): dialog
callid='6447fbad-2151-4250-dfc9-44536257cb88' found on entry 183, dir=1
 7(3205) DEBUG: ims_dialog [dlg_profile.c:605]: is_dlg_in_profile():
Current dlg found 7(3205) DEBUG: ims_dialog [dlg_profile.c:612]:
is_dlg_in_profile(): Running through linkers 7(3205) DEBUG: ims_dialog
[dlg_profile.c:614]: is_dlg_in_profile(): Profile matches 7(3205) DEBUG:
ims_dialog [dlg_profile.c:616]: is_dlg_in_profile(): Profile has value is
zero returning true 7(3205) DEBUG: ims_dialog [dlg_hash.c:1056]:
unref_dlg(): unref dlg 0xb200ac10 with 1 -> 1
 7(3205) DEBUG: ims_dialog [dlg_profile.c:596]: is_dlg_in_profile():
Getting current dialog 7(3205) DEBUG: ims_dialog [dlg_hash.h:414]:
match_dialog(): No dlg outs yet...
 7(3205) DEBUG: ims_dialog [dlg_hash.c:915]: internal_get_dlg(): ref dlg
0xb200ac10 with 1 -> 2
 7(3205) DEBUG: ims_dialog [dlg_hash.c:918]: internal_get_dlg(): dialog
callid='6447fbad-2151-4250-dfc9-44536257cb88' found on entry 183, dir=1
 7(3205) DEBUG: ims_dialog [dlg_profile.c:605]: is_dlg_in_profile():
Current dlg found 7(3205) DEBUG: ims_dialog [dlg_profile.c:612]:
is_dlg_in_profile(): Running through linkers 7(3205) DEBUG: ims_dialog
[dlg_hash.c:1056]: unref_dlg(): unref dlg 0xb200ac10 with 1 -> 1
 7(3205) DEBUG: siputils [checks.c:120]: has_totag(): no totag
 7(3205) DEBUG: <core> [core/socket_info.c:564]: grep_sock_info(): checking
if host==us: 13==14 && [koffee-ims.in] == [192.168.99.140]
 7(3205) DEBUG: <core> [core/socket_info.c:567]: grep_sock_info(): checking
if port 6060 (advertise 0) matches port 5060
 7(3205) DEBUG: <core> [core/forward.c:412]: check_self(): host != me
 7(3205) ERROR: <script>: No=9 Terminating ---403  Forbidden - Domain not
served
 7(3205) DEBUG: <core> [core/msg_translator.c:159]: check_via_address():
(192.168.99.140, 192.168.99.140, 1)
/-------------------------------------------------------------------------------------------------------------------