[OpenSER-Users] Bug or bad config?
Bogdan-Andrei Iancu
bogdan at voice-system.ro
Fri Jul 20 08:18:51 CEST 2007
Hi Antonio,
looks like a configuration error - probably there is a failure_route
where no branch is added before doing t_relay().
Regards,
Bogdan
Antonio Reale wrote:
> Hi all,
> I’m trying to set up conditional call forwarding using an openser.cfg
> created with sip:wizard on sipwise.com.
> On ring-timeout before response 408 I receive a "500 I'm terribly sorry..."
> message.
>
> ngrep output:
> ----------------------------------------------------------------------
> U proxyip:5060 -> clientip:1025
> SIP/2.0 500 I'm terribly sorry, server error occurred (1/SL).
> Via: SIP/2.0/UDP
> clientip;branch=z9hG4bK0a0a2d5600000054469e38f600007d4800000065;rport=1025.
> From: "unknown" <sip:9991 at proxyip>;tag=6c5264b687a.
> To: <sip:8888 at proxyip>;tag=89c3d91cf34558b4440b4dea7bd37a3b.9860.
> Call-ID: EDC29EF258D44A69818BF2960CF191360x0a0a2d56.
> CSeq: 2 INVITE.
> Server: OpenSer (1.1.1-notls (i386/linux)).
> Content-Length: 0.
> .
>
> #
> U proxyip:5060 -> clientip:1025
> SIP/2.0 408 Request Timeout.
> Via: SIP/2.0/UDP
> clientip;branch=z9hG4bK0a0a2d5600000054469e38f600007d4800000065;rport=1025.
> From: "unknown" <sip:9991 at proxyip>;tag=6c5264b687a.
> To: <sip:8888 at proxyip>;tag=1da87856efbb12e9687f30fa08f307cb-9860.
> Call-ID: EDC29EF258D44A69818BF2960CF191360x0a0a2d56.
> CSeq: 2 INVITE.
> Server: OpenSer (1.1.1-notls (i386/linux)).
> Content-Length: 0.
> -------------------------------------------------------------------------
>
>
> With tail -f /var/log/message I see (output lines are cutted):
> -------------------------------------------------------------------------
> Jul 18 18:55:22 proxy /usr/sbin/openser[5615]: NAT-Reply - S=180 D=Ringing
> F=sip....
> Jul 18 18:55:26 proxy /usr/sbin/openser[5620]: Redirect from UAC intercepted
> - M=INVITE RURI=sip:....
> Jul 18 18:55:26 proxy /usr/sbin/openser[5620]: Clear callee preferences -
> M=INVITE RURI=sip:....
> Jul 18 18:55:26 proxy /usr/sbin/openser[5620]: is_uri_host_local(): Branch
> is missing, error in script Jul 18 18:55:26 proxy /usr/sbin/openser[5620]:
> Call to foreign domain - M=INVITE RURI=sip:....
> Jul 18 18:55:26 proxy /usr/sbin/openser[5620]: Request leaving server,
> D-URI='' - M=INVITE RURI=sip:....
> Jul 18 18:55:26 proxy /usr/sbin/openser[5620]: ERROR:tm:t_forward_nonack: no
> branch for forwarding Jul 18 18:55:26 proxy /usr/sbin/openser[5620]:
> ERROR:tm:w_t_relay: t_forward_nonack failed
> --------------------------------------------------------------------------
>
> How can I solve this problem?
> Attached the routing section of openser.cfg (full file was too big for
> mailing list).
> Thanks in advance. Best regards.
>
> --
> Antonio
>
>
>
>
> ------------------------------------------------------------------------
>
> ########################################################################
> # Request route 'main'
> ########################################################################
> route[0]
> {
> xlog("L_INFO", "New request - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> force_rport();
> if(msg:len > max_len)
> {
>
> xlog("L_INFO", "Message too big - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("513", "Message Too Big");
> exit;
> }
> if (!mf_process_maxfwd_header("10"))
> {
>
> xlog("L_INFO", "Too many hops - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("483", "Too Many Hops");
> exit;
> }
> if(!is_method("REGISTER"))
> {
> if(nat_uac_test("19"))
> {
> record_route(";nat=yes");
> }
> else
> {
> record_route();
> }
> }
> if(is_method("CANCEL") || is_method("BYE"))
> {
> end_media_session();
> }
> if(loose_route())
> {
> if(!has_totag())
> {
>
> xlog("L_INFO", "Initial loose-routing rejected - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("403", "Initial Loose-Routing Rejected");
> exit;
> }
> if(nat_uac_test("19") || search("^Route:.*;nat=yes"))
> {
> fix_nated_contact();
> setflag(6);
> }
>
> route(8);
> }
> if(is_method("REGISTER"))
> {
> route(7);
> }
> if(is_method("INVITE"))
> {
> route(9);
> }
> if(is_method("CANCEL") || is_method("ACK"))
> {
> route(15);
> }
>
> route(16);
> }
>
> ########################################################################
> # Request route 'clear-usr-preferences-caller'
> ########################################################################
> route[1]
> {
> xlog("L_INFO", "Clear caller preferences - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> avp_delete("$avp(s:caller_cli)/g");
> avp_delete("$avp(s:clir)/g");
>
> }
>
> ########################################################################
> # Request route 'clear-usr-preferences-callee'
> ########################################################################
> route[2]
> {
> xlog("L_INFO", "Clear callee preferences - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> avp_delete("$avp(s:callee_fr_inv_timer)/g");
> avp_delete("$avp(s:cfu)/g");
> avp_delete("$avp(s:cfc)/g");
>
> }
>
> ########################################################################
> # Request route 'usr-preferences-caller'
> ########################################################################
> route[3]
> {
> route(1);
> xlog("L_INFO", "Load caller preferences for uuid '$avp(s:caller_uuid)' - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> # load caller avps
> avp_db_load("$avp(s:caller_uuid)", "*");
> avp_copy("$avp(s:cli)", "$avp(s:caller_cli)/d");
> if(is_avp_set("$avp(s:clir)/n") && avp_check("$avp(s:clir)", "eq/i:1"))
> {
> # mark for anonymization
> setflag(28);
> }
>
> }
>
> ########################################################################
> # Request route 'usr-preferences-callee'
> ########################################################################
> route[4]
> {
> xlog("L_INFO", "Load callee preferences for uuid '$avp(s:callee_uuid)' - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> # load callee avps
> avp_db_load("$avp(s:callee_uuid)", "*");
> if(is_avp_set("$avp(s:cfu)/s"))
> {
>
> xlog("L_INFO", "Call-forward-unconditional to '$avp(s:cfu)' found - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> avp_delete("$avp(s:caller_uuid)/g");
> avp_copy("$avp(s:callee_uuid)", "$avp(s:caller_uuid)/d");
> avp_pushto("$ru", "$avp(s:cfu)");
>
> route(3);
> route(10);
> exit;
> }
> if(is_avp_set("$avp(s:ringtimeout)/n"))
> {
>
> xlog("L_INFO", "Setting ring timeout to $avp(s:ringtimeout) secs - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> avp_copy("$avp(s:ringtimeout)", "$avp(s:callee_fr_inv_timer)/d");
> }
>
> }
>
> ########################################################################
> # Request route 'clir'
> ########################################################################
> route[5]
> {
> if(isflagset(28) && !isflagset(27))
> {
> setflag(27);
>
> xlog("L_INFO", "Anonymize caller - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> uac_replace_from("Anonymous","sip:anonymous at anonymous.invalid");
> if(is_present_hf("Privacy"))
> {
> remove_hf("Privacy");
> }
> append_hf("Privacy: id\r\n");
> }
>
> }
>
> ########################################################################
> # Request route 'stop-media-proxy'
> ########################################################################
> route[6]
> {
> if(isflagset(22))
> {
> end_media_session();
> }
>
> }
>
> ########################################################################
> # Request route 'base-route-register'
> ########################################################################
> route[7]
> {
> sl_send_reply("100", "Trying");
> if(!www_authorize("", "subscriber"))
> {
>
> xlog("L_INFO", "Register authentication failed - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> www_challenge("", "0");
> exit;
> }
> if(!check_to())
> {
>
> xlog("L_INFO", "Spoofed To-URI detected - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("403", "Spoofed To-URI Detected");
> exit;
> }
> consume_credentials();
> if(!search("^Contact:[ ]*\*") && nat_uac_test("19"))
> {
> fix_nated_register();
> setflag(6);
> }
> if(!save("location"))
> {
>
> xlog("L_ERR", "Saving contact failed - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_reply_error();
> exit;
> }
>
> xlog("L_INFO", "Registration successful - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> exit;
>
> }
>
> ########################################################################
> # Request route 'base-outbound'
> ########################################################################
> route[8]
> {
> if(is_present_hf("P-Asserted-Identity"))
> {
> remove_hf("P-Asserted-Identity");
> }
> if(is_present_hf("Remote-Party-ID"))
> {
> remove_hf("Remote-Party-ID");
> }
> if(is_avp_set("$avp(s:caller_cli)/s"))
> {
> if(!isflagset(28))
> {
>
> xlog("L_INFO", "Set caller CLI '$avp(s:caller_cli)' - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> append_hf("P-Asserted-Identity: <$avp(s:caller_cli)>\r\n");
> }
> }
>
> route(5);
> if(isflagset(6))
> {
> if(!isflagset(22) && !search("^Content-Length:[ ]*0"))
> {
> setflag(22);
> use_media_proxy();
> }
>
> t_on_reply("2");
> }
> else
> {
>
> t_on_reply("1");
> }
> if(!isflagset(21))
> {
>
> t_on_failure("2");
> }
> if(isflagset(29))
> {
> append_branch();
> }
> if(is_present_hf("Proxy-Authorization"))
> {
> consume_credentials();
> }
>
> xlog("L_INFO", "Request leaving server, D-URI='$du' - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> if(!t_relay())
> {
> sl_reply_error();
> if(is_method("INVITE") && isflagset(6))
> {
> end_media_session();
> }
> }
> exit;
>
> }
>
> ########################################################################
> # Request route 'base-route-invite'
> ########################################################################
> route[9]
> {
> sl_send_reply("100", "Trying");
> if(from_gw())
> {
> avp_write("s:0", "$avp(s:caller_uuid)");
>
> xlog("L_INFO", "Call from PSTN' - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> setflag(23);
> }
> else
> {
> if(allow_trusted())
> {
> if(is_avp_set("$avp(s:peer_uuid)/s"))
> {
> # use tag-column from trusted-table as uuid for this caller
> avp_copy("$avp(s:peer_uuid)", "$avp(s:caller_uuid)/d");
> }
> else
> {
> # if no uuid is set, use "0" as default uuid
> avp_write("s:0", "$avp(s:caller_uuid)");
> }
>
> xlog("L_INFO", "Call from trusted peer with uuid '$avp(s:caller_uuid)' - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> if(!is_domain_local("$ruri"))
> {
>
> xlog("L_INFO", "Rejecting peering attempt with non-local request domain - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("403", "Relaying Denied");
> exit;
> }
> #setflag(23);
> }
> else
> {
> if(!proxy_authorize("", "subscriber"))
> {
>
> xlog("L_INFO", "Proxy authentication failed - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> proxy_challenge("", "0");
> exit;
> }
> if(!check_from())
> {
>
> xlog("L_INFO", "Spoofed From-URI detected - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("403", "Spoofed From-URI Detected");
> exit;
> }
> }
> }
>
> route(3);
> if(nat_uac_test("19"))
> {
> fix_nated_contact();
> setflag(6);
> }
>
> route(10);
> }
>
> ########################################################################
> # Request route 'invite-find-callee'
> ########################################################################
> route[10]
> {
> if(alias_db_lookup("dbaliases"))
> {
>
> xlog("L_INFO", "Callee was aliased - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> }
>
> route(2);
> if(!is_domain_local("$ruri"))
> {
> setflag(20);
> avp_write("s:0", "$avp(s:callee_uuid)");
>
> route(12);
> }
> avp_delete("$avp(s:callee_uuid)");
> avp_db_query("select uuid from subscriber where username = '$rU'", "$avp(s:callee_uuid)");
> if(is_avp_set("$avp(s:callee_uuid)/s"))
> {
>
> xlog("L_INFO", "Callee is local, uuid='$avp(s:callee_uuid)' - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(11);
> }
> else
> {
> avp_write("s:0", "$avp(s:callee_uuid)");
>
> xlog("L_INFO", "Callee is not local - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(12);
> }
> exit;
>
> }
>
> ########################################################################
> # Request route 'invite-to-internal'
> ########################################################################
> route[11]
> {
> route(4);
> if(!lookup("location"))
> {
>
> xlog("L_INFO", "Local user offline - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("404", "User Offline");
> }
> else
> {
>
> xlog("L_INFO", "Local user online - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(8);
> }
> exit;
>
> }
>
> ########################################################################
> # Request route 'invite-to-external'
> ########################################################################
> route[12]
> {
> if(isflagset(20))
> {
>
> xlog("L_INFO", "Call to foreign domain - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(8);
> exit;
> }
>
> route(14);
> if(!isflagset(23))
> {
> # don't allow calls relaying from PSTN to PSTN, if not explicitely forwarded
> if(uri =~ "^sip:[0-9]+@")
> {
> # only route numeric users to PSTN
> if(!load_gws())
> {
>
> xlog("L_ERR", "Error loading PSTN gateways - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("503", "PSTN Termination Currently Unavailable");
> exit;
> }
> if(!next_gw())
> {
>
> xlog("L_ERR", "No PSTN gateways available - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("503", "PSTN Termination Currently Unavailable");
> exit;
> }
> setflag(21);
>
> t_on_failure("1");
> route(8);
> }
> }
>
> xlog("L_INFO", "Call to unknown user - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("404", "User Not Found");
> exit;
>
> }
>
> ########################################################################
> # Request route 'normalize-e164'
> ########################################################################
> route[13]
> {
> # European numbering plans look like this:
> # CC = country code (i.e. 43 for Austria)
> # NDC = national destination code (i.e. 1 for Vienna)
> # SN = subscriber number (i.e. 4001234)
> #
> # CC + NDC + SN, i.e. 4314001234
> #
> # Within the same CC+NDC, it can be omitted, so if
> # +4314001234 wants to call +4315002345, one can dial
> # just 5002345.
> #
> # Within the same CC, CC can be ommitted and a "0" is prefixed
> # to NDC, so if +4314001234 wants to call +4326003456,
> # one can dial 026003456.
> #
> # For international calls, either "00" or + is prefixed, like
> # +49123456780 or 0049123456789.
> #
> avp_delete("$avp(s:orig_callee_user)/g");
> avp_write("$rU", "$avp(s:orig_callee_user)");
> if(uri =~ "^sip:(\+[1-9])?[0-9]+@")
> {
> # looks like a PSTN number
> if(uri =~ "^sip:0[1-9][0-9]+@")
> {
> # we have format 0+NDC+SN
> strip(1);
> prefix("+39");
> }
> else if(uri =~ "^sip:00[1-9]+@")
> {
> # we have format 00 + CC + NDC + SN
> strip(2);
> prefix("+");
> }
> else if(!uri =~ "^sip:\+[1-9][0-9]+@")
> {
> # unknown format, maybe NDC wasn't added before?
>
> xlog("L_INFO", "Not normalized callee '$avp(s:orig_callee_user)' to E.164 format - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> return(-1);
> }
> # else we have "+" + CC + NDC + SN
>
> xlog("L_INFO", "Normalized callee '$avp(s:orig_callee_user)' to E.164 format '$rU' - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> return(1);
> }
> else
> {
>
> xlog("L_INFO", "Not normalized callee '$avp(s:orig_callee_user)' to E.164 format - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> return(-1);
> }
>
> }
>
> ########################################################################
> # Request route 'lookup-enum'
> ########################################################################
> route[14]
> {
> route(13);
> if(retcode == 1)
> {
> if(enum_query("e164.org."))
> {
> # TODO: do GW fallback (load gws, set failure-route)?
>
> xlog("L_INFO", "ENUM query succeeded - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(8);
> exit;
> }
> else
> {
>
> xlog("L_INFO", "ENUM query failed - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> # ENUM query failed, revert $rU
> avp_pushto("$ru/username", "$avp(s:orig_callee_user)");
> }
> }
>
> }
>
> ########################################################################
> # Request route 'base-route-local'
> ########################################################################
> route[15]
> {
> t_on_reply("1");
> if(t_check_trans())
> {
>
> xlog("L_INFO", "Request leaving server - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> if(!t_relay())
> {
> sl_reply_error();
> }
> }
> else
> {
>
> xlog("L_INFO", "Dropping mis-routed request - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> }
> exit;
>
> }
>
> ########################################################################
> # Request route 'base-route-generic'
> ########################################################################
> route[16]
> {
> xlog("L_INFO", "Method not supported - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> sl_send_reply("501", "Method Not Supported Here");
> exit;
>
> }
>
> ########################################################################
> # Request route 'base-filter-failover'
> ########################################################################
> route[17]
> {
> if(!t_check_status("408|500|503"))
> {
>
> xlog("L_INFO", "No failover routing needed for this response code - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(6);
> exit;
> }
>
> }
>
> ########################################################################
> # Reply route 'base-standard-reply'
> ########################################################################
> onreply_route[1]
> {
> xlog("L_INFO", "Reply - S=$rs D=$rr F=$fu T=$tu IP=$si ID=$ci\n");
> exit;
>
> }
>
> ########################################################################
> # Reply route 'base-nat-reply'
> ########################################################################
> onreply_route[2]
> {
> xlog("L_INFO", "NAT-Reply - S=$rs D=$rr F=$fu T=$tu IP=$si ID=$ci\n");
> if(nat_uac_test("1"))
> {
> fix_nated_contact();
> }
> if(isflagset(6) && status=~"(180)|(183)|2[0-9][0-9]")
> {
> if(!search("^Content-Length:[ ]*0"))
> {
> use_media_proxy();
> }
> }
> exit;
>
> }
>
> ########################################################################
> # Failure route 'pstn-failover'
> ########################################################################
> failure_route[1]
> {
> xlog("L_INFO", "Failure route for PSTN entered - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(17);
> if(!next_gw())
> {
>
> xlog("L_ERR", "Failed to select next PSTN gateway - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(6);
> exit;
> }
>
> t_on_failure("1");
> route(8);
> }
>
> ########################################################################
> # Failure route 'base-standard-failure'
> ########################################################################
> failure_route[2]
> {
> if(t_check_status("422|481|487"))
> {
>
> xlog("L_INFO", "Final reply - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(6);
> exit;
> }
>
> t_on_branch("1");
> xlog("L_INFO", "Redirect from UAC intercepted - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(10);
> if(avp_check("$avp(s:cfc)", "re/^.+$"))
> {
> avp_pushto("$ru", "$avp(s:cfc)");
> setflag(29);
> append_branch();
>
> t_on_branch("1");
> xlog("L_INFO", "CFC detected - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> route(10);
> }
>
> route(17);
> route(6);
> }
>
> ########################################################################
> # Branch route 'cfc-drop-local'
> ########################################################################
> branch_route[1]
> {
> if(!is_domain_local("$ruri"))
> {
>
> xlog("L_INFO", "Dropping local branch - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci\n");
> drop();
> }
>
> }
> ------------------------------------------------------------------------
>
> _______________________________________________
> Users mailing list
> Users at openser.org
> http://openser.org/cgi-bin/mailman/listinfo/users
>
More information about the sr-users
mailing list