[OpenSIPS-Users] Crach Opensips in failure d_routing after 50X response
mickael at winlux.fr
mickael at winlux.fr
Mon Mar 19 12:12:49 CET 2012
> Hi list
> I want expose my crash problem.
>
> *my sip network :*
> I have two Opensips statefull mode in freebsd (8.1-RELEASE FreeBSD
> 8.1-RELEASE) and two Mediaproxy in debian (Linux 2.6.32-5-686).
>
> *my problem :*
> Randomly, first Opensips crash in failure route , after 50X response,
> juste before t_relay. But the second proxy never crashed in this case.
>
> Look below :
>
> *Log opensips:*
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]: NEW CALL : call-id
> 539361d23447189d7db8614164c446c7 at domaincustomer
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomerIn ROUTE DELXASTERISK - fu
> : sip:+33689898989 at domaincustomer, ru : sip:+33898989898 at IP_proxy , si :
> IP_customer
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomerIn ROUTE FORMATRURI - fu :
> sip:+33689898989 at domaincustomer, ru : sip:+33898989898 at IP_proxy , si :
> IP_customer
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomer
>
> Outgoing call for: [sip:+33689898989 at domaincustomer/sip:+33898989898
> @IP_proxy/sip:+33898989898
> @IP_proxy/539361d23447189d7db8614164c446c7 at domaincustomer]
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomer Call control: countOUT is
> OK [10/60/sip:+33689898989 at domaincustomer/domaincustomer]
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomer In ROUTE DROUTING - fu :
> sip:+33689898989 at domaincustomer, ru : sip:+33898989898 at IP_proxy , si :
> IP_customer
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomer We add the + prefix
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomer In ROUTE FORMATOUT - fu :
> sip:+33689898989 at domaincustomer, ru : sip:+33898989898 at IP_Provider1:5060
> , si : IP_customer
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomer We rewrite TO with ru :
> sip:+33898989898 at IP_Provider1:5060
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomer In fU ANONYMOUS or fU
> with letters - fU : +33689898989
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomer There's a PAI Header - fu
> : sip:+33689898989 at domaincustomer, ru : sip:+33898989898 at IP_Provider1:5060
> , si : IP_customer
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomer ROUTE PAIAUTHORIZE - OUT
> CALL AUTHORIZE - AI: sip:+33689898989 at 10.10.10.1:5060 - for: [sip:
> +33689898989 at domaincustomer/sip:+33898989898 at IP_proxy/sip:+33898989898
> @IP_Provider1:5060/539361d23447189d7db8614164c446c7 at domaincustomer]
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59860]:
> 539361d23447189d7db8614164c446c7 at domaincustomer
T<539361d23447189d7db8614164c446c7 at domaincustomerT>o
> ROUTE DELETECODDECS
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59868]:
> 539361d23447189d7db8614164c446c7 at domaincustomer In ONREPLY ROUTE 2 - fu :
> sip:+33689898989 at IP_proxy , ru : <null> , si : IP_Provider1, status : 100
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59869]:
> 539361d23447189d7db8614164c446c7 at domaincustomer In ONREPLY ROUTE 2 - fu :
> sip:+33689898989 at IP_proxy , ru : <null> , si : IP_Provider1, status : 183
>
> Mar 19 10:22:01 proxy1 /usr/local/sbin/opensips[59869]:
> 539361d23447189d7db8614164c446c7 at domaincustomer DROP 183
>
> Mar 19 10:22:04 proxy1 /usr/local/sbin/opensips[59871]:
> 539361d23447189d7db8614164c446c7 at domaincustomer In ONREPLY ROUTE 2 - fu :
> sip:+33689898989 at IP_proxy , ru : <null> , si : IP_Provider1, status : 180
>
> Mar 19 10:22:20 proxy1 /usr/local/sbin/opensips[59868]:
> 539361d23447189d7db8614164c446c7 at domaincustomer In ONREPLY ROUTE 2 - fu :
> sip:+33689898989 at IP_proxy , ru : <null> , si : IP_Provider1, status : 183
>
> Mar 19 10:22:20 proxy1 /usr/local/sbin/opensips[59868]:
> 539361d23447189d7db8614164c446c7 at domaincustomer DROP 183
>
> Mar 19 10:22:23 proxy1 /usr/local/sbin/opensips[59869]:
> 539361d23447189d7db8614164c446c7 at domaincustomer In ONREPLY ROUTE 2 - fu :
> sip:+33689898989 at IP_proxy , ru : <null> , si : IP_Provider1, status : 183
>
> Mar 19 10:22:23 proxy1 /usr/local/sbin/opensips[59869]:
> 539361d23447189d7db8614164c446c7 at domaincustomer DROP 183
>
> *Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59868]: **
> 539361d23447189d7db8614164c446c7 at domaincustomer*<539361d23447189d7db8614164c446c7 at domaincustomer>
> * In ONREPLY ROUTE 2 - fu : sip:+33689898989 at IP_proxy , ru : <null> , si
> : IP_Provider1, status : 500*
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59868]:
> 539361d23447189d7db8614164c446c7 at domaincustomer In FAILURE ROUTE DROUTING
> - fu : sip:+33689898989 at domaincustomer, ru :
sip:+33898989898 at IP_Provider1:5060
> , si : IP_customer
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59868]:
> 539361d23447189d7db8614164c446c7 at domaincustomer DR use NEXT GW to go to
> ru : sip:33898989898 at 81.23.34.140:5060
>
> *Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59868]: **
> 539361d23447189d7db8614164c446c7 at domaincustomer*<539361d23447189d7db8614164c446c7 at domaincustomer>
> * In isflaset29?, before command prefix + Ru modify to ru :
> sip:+33898989898 at IP_BACKUP_PROVIDER_1:5060<http://sip:+33898989898@81.23.34.140:5060>
> *
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:core:handle_sigs: child process 59868 exited by a signal 11
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:core:handle_sigs: core was generated
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:core:handle_sigs: terminating due to SIGCHLD
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59873]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59871]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59863]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59870]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59861]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59869]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59860]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59862]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59872]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59864]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59856]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59855]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59859]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59865]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59853]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59857]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59867]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59866]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59858]: INFO:core:sig_usr:
> signal 15 received
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:pike:pike_exit: destroying...
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:snmpstats:mod_destroy: The SNMPStats module got the kill signal
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:snmpstats:mod_destroy: Shutting down the AgentX Sub-Agent!
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:db_mysql:re_init_statement: query is <update dialog set
> state=?,timeout=?,caller_cseq=?,callee_cseq=?,vars=?,profiles=?,script_flags=?
> where hash_entry=? AND hash_id=?>, ptr=0x0
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:db_mysql:switch_state_to_disconnected: disconnect event for 0x8250584
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:db_mysql:reset_all_statements: reseting all statements on connection:
> (0x8250b14) 0x8250584
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:db_mysql:connect_with_retry: re-connected successful for 0x8250584
>
> Mar 19 10:22:40 proxy1 /usr/local/sbin/opensips[59852]:
> INFO:db_mysql:re_init_statement: query is <delete from location where
> expires<? AND expires!=?>, ptr=0x0
>
>
> *Code "route failure"*
>
> failure_route[faildrouting]
> {
> if($avp(s:debugcall)=~"yes"){ xlog("L_INFO","$ci In FAILURE ROUTE
> DROUTING - fu : $fu , ru : $ru , si : $si \n"); }
> t_on_failure("faildrouting");
>
> if (t_was_cancelled())
> {
> exit;
> }
>
> if (t_check_status("40[58]|50[0-5]")) {
>
> if(use_next_gw())
> {
> if($avp(s:debugcall)=~"yes"){ xlog("L_INFO","$ci
> DR use NEXT GW to go to ru : $ru \n"); }
> if(isflagset(29))
> {
> prefix("+");
> *if($avp(s:debugcall)=~"yes"){
> xlog("L_INFO","$ci In isflaset29?, before command prefix + Ru modify to ru
> : $ru \n"); }*
> }
>
>
> if(t_relay())
> {
> if($avp(s:debugcall)=~"yes"){
> xlog("L_INFO","$ci In t_relay, And t_relay: OK to ru : $ru \n"); }
> }
> }
> else
> {
> xlog("L_ERR","$ci DR NEXT GW not found\n");
> }
> }
> }
>
>
>
Thanks in advance.
More information about the Users
mailing list