Hi all, I am tryng to understand how OpenSIPS works and i am playng with OpenSIPS liveCD. I am able to register to it user and make outbound call toward asterisk machine ( is a separated server with different IP ). The problem is when an asterisk user try to call a OpenSIPS user. I always have these logs:
Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_msg: SIP Request: Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_msg: method: <INVITE> Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_msg: uri: <sip:[email protected]> Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_msg: version: <SIP/2.0> Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_headers: flags=2 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_via_param: found param type 232, <branch> = <z9hG4bK144b79e0>; state=16 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_via: end of header reached, state=5 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_headers: via found, flags=2 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_headers: this is the first via Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:receive_msg: After parse_msg... Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:receive_msg: preparing to run routing scripts... Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_headers: flags=100 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:maxfwd:is_maxfwd_present: value = 70 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:check_ip_address: params 172.16.52.123, 172.16.52.123, 0 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_headers: flags=ffffffffffffffff Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_to: end of header reached, state=10 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_to: display={}, ruri={sip:[email protected]} Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:get_hdr_field: <To> [26]; uri=[sip:[email protected]] Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:get_hdr_field: to body [<sip:[email protected]>^M ] Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:get_hdr_field: cseq <CSeq>: <102> <INVITE> Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:get_hdr_field: content_length=691 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:get_hdr_field: found end of header Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_headers: flags=ffffffffffffffff Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:uri:has_totag: no totag Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_headers: flags=78 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:tm:t_lookup_request: start searching: hash=4543, isACK=0 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:tm:matching_3261: RFC3261 transaction matching failed Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:tm:t_lookup_request: no transaction found Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_to_param: tag=as575851dd Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_to: end of header reached, state=29 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_to: display={"Thomson 3950"}, ruri={sip:[email protected]} Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:parse_headers: flags=ffffffffffffffff Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:check_ip_address: params 172.16.52.123, 172.16.52.123, 0 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:destroy_avp_list: destroying list (nil) Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3211]: DBG:core:receive_msg: cleaning up Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_msg: SIP Request: Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_msg: method: <ACK> Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_msg: uri: <sip:[email protected]> Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_msg: version: <SIP/2.0> Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_headers: flags=2 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_via_param: found param type 232, <branch> = <z9hG4bK144b79e0>; state=16 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_via: end of header reached, state=5 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_headers: via found, flags=2 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_headers: this is the first via Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:receive_msg: After parse_msg... Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:receive_msg: preparing to run routing scripts... Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_headers: flags=8 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_to_param: tag=988e82a5532bada72d6d9bbb7ebb56fd.647c Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_to: end of header reached, state=29 Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:parse_to: display={}, ruri={sip:[email protected]} Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:get_hdr_field: <To> [68]; uri=[sip:[email protected]] Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:get_hdr_field: to body [<sip:[email protected]>] Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:sl:sl_filter_ACK: local ACK found -> dropping it! Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:destroy_avp_list: destroying list (nil) Jul 27 04:08:26 opensips /usr/local/opensips_proxy/sbin/opensips[3210]: DBG:core:receive_msg: cleaning up and U 2011/07/27 04:12:25.959849 172.16.52.123:5060 -> 172.16.52.139:5060 INVITE sip:[email protected] SIP/2.0. Via: SIP/2.0/UDP 172.16.52.123:5060;branch=z9hG4bK4359b3d8. Max-Forwards: 70. From: "Thomson 3950" <sip:[email protected]>;tag=as4f95741d. To: <sip:[email protected]>. Contact: <sip:[email protected]:5060>. Call-ID: [email protected]. CSeq: 102 INVITE. User-Agent: FPBX-2.9.0(1.8.5.0). Date: Wed, 27 Jul 2011 08:14:44 GMT. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH. Supported: replaces, timer. Content-Type: application/sdp. Content-Length: 693. . v=0. o=root 1272428081 1272428081 IN IP4 172.16.52.123. s=Asterisk PBX 1.8.5.0. c=IN IP4 172.16.52.123. b=CT:384. t=0 0. m=audio 17670 RTP/AVP 8 0 3 112 5 10 7 111 9 118 101. a=rtpmap:8 PCMA/8000. a=rtpmap:0 PCMU/8000. a=rtpmap:3 GSM/8000. a=rtpmap:112 AAL2-G726-32/8000. a=rtpmap:5 DVI4/8000. a=rtpmap:10 L16/8000. a=rtpmap:7 LPC/8000. a=rtpmap:111 G726-32/8000. a=rtpmap:9 G722/8000. a=rtpmap:118 L16/16000. a=rtpmap:101 telephone-event/8000. a=fmtp:101 0-16. a=ptime:20. a=sendrecv. m=video 16088 RTP/AVP 26 31 34 98 99 104. a=rtpmap:26 JPEG/90000. a=rtpmap:31 H261/90000. a=rtpmap:34 H263/90000. a=rtpmap:98 h263-1998/90000. a=rtpmap:99 H264/90000. a=rtpmap:104 MP4V-ES/90000. a=sendrecv. U 2011/07/27 04:12:25.962767 172.16.52.139:5060 -> 172.16.52.123:5060 SIP/2.0 403 No relaying. Via: SIP/2.0/UDP 172.16.52.123:5060;branch=z9hG4bK4359b3d8;rport=5060. From: "Thomson 3950" <sip:[email protected]>;tag=as4f95741d. To: <sip:[email protected]>;tag=988e82a5532bada72d6d9bbb7ebb56fd.13cf. Call-ID: [email protected]. CSeq: 102 INVITE. Server: OpenSIPS (1.6.3-notls (i386/linux)). Content-Length: 0. . U 2011/07/27 04:12:25.964102 172.16.52.123:5060 -> 172.16.52.139:5060 ACK sip:[email protected] SIP/2.0. Via: SIP/2.0/UDP 172.16.52.123:5060;branch=z9hG4bK4359b3d8. Max-Forwards: 70. From: "Thomson 3950" <sip:[email protected]>;tag=as4f95741d. To: <sip:[email protected]>;tag=988e82a5532bada72d6d9bbb7ebb56fd.13cf. Contact: <sip:[email protected]:5060>. Call-ID: [email protected]. CSeq: 102 ACK. User-Agent: FPBX-2.9.0(1.8.5.0). Content-Length: 0. IP 172.16.52.139 = OpenSIPS IP 172.16.52.123 = Asterisk Can you help me where is the problem??? Thanks -- View this message in context: http://opensips-open-sip-server.1449251.n2.nabble.com/Inbound-call-not-works-tp6625495p6625495.html Sent from the OpenSIPS - Users mailing list archive at Nabble.com. _______________________________________________ Users mailing list [email protected] http://lists.opensips.org/cgi-bin/mailman/listinfo/users
