sr-users April 2004

sr-users@lists.kamailio.org

138 participants
266 discussions

by Kapil Dhawan

Hi I like to implement Call Hunting using SER....What i am doing right now is.....i am making a profile and treating it as hunt group....and now making other profiles which are members of that group...maintaining a file while consists of all membrs....and their status.......Now when 111 calls 222 and 222 is busy lets say...in that case..........SER says that 222 is busy...now i need to generate INVITE again.........with user 333 i can rewrite uri using code....but how can i change the method to INVITE and send that again......and one thing how can we generate BYE messages on our own....like how can we write a small code which will generate BYE using some call-seqid... regards _________________________________________________________________ Old pals, ex-flames, great times. Catch up with the past! Sign up now! http://www.batchmates.com/msn.asp

20 years, 10 months

[Serusers] Re: [Serdev] call drop

by Jiri Kuthan

At 03:17 AM 4/8/2004, Raymond Chen wrote: >Dear all, > >We¡¯ve setup a call scenario AS5300-¨¤SER¨¤as5300 but all calls drop around 1 minute after connection, SER does not keep transactions in memory for ever. If you wish them to be kept longer, try longer TM timers. Nevertheless, the reply in question should be delivered statelessly even if the transaction context is already expired. -jiri

20 years, 10 months

[Serusers] 478 Unresolveable destination

by Shu-Liang Lee

Hello all: How to solve this question? shuliang =============== That means the server received a hostname in the Request-URI but wasn't able to resolve the hostname to an IP address. Jan. On 13-01 09:51, CURRO_DOMINGUEZ wrote: > Hello and thanks to the list for your answers. > > I have developed a simple test network in a private LAN whit 2 PC: a > SER server and a client. > When I try to connect the SIP client, the server answer with this > message: > > 478 Unresolveable destination. > > SER and mysql are running. I have serweb correctly installed and I can > add users. I use the user admin, pass heslo (which is in subscriber > table) to login with the SIP client. > > Any idea about what's happenning? Any help will be fantastic. > > Thank you very much for your time. > > Curro >

20 years, 10 months

RE: [Serusers] Sems Error

by Shirley

Hi, Thank you for your prompt reply. I have tested :~ set log_stderr=yes and fork=no and debug=3 in sems.conf. I have attached the log. Please help. <<SemsError1.txt>> <<sems.conf>> I have also tested this ps ax | grep sems. I get this result:~ [root@sipserver2 root]# ps ax | grep sems 5518 ? S 1:25 gedit file:///etc/sems/sems.conf 7805 pts/0 S 0:00 grep sems Regards, Shirley > -----Original Message----- > From: Ulrich Abend [SMTP:ullstar@iptel.org > Sent: Thursday, April 08, 2004 12:18 AM > To: Shirley > Cc: serusers(a)lists.iptel.org > Subject: Re: [Serusers] Sems Error > > Hi, > > try to set log_stderr=yes and fork=no and debug=3 in sems.conf for > testing, it > should produce a lot of debugging output on your console when starting up. > > There are a lot of possible reasons for SEMS not starting, please post the > > debugging output either from the commands above or from /var/log/syslog > (under redhat the file might be another one under /var/log/ ...) > > You can also check is sems runs by calling in your shell: > > ps ax | grep sems > > Regards, > > Uli. > > P.S.: Please always CC to the list, others might answer quicker than me > :-) > > On Wednesday 07 April 2004 14:43, Shirley wrote: > > Hi, > > > > Thank you for your reply. How to make sure that the SEMS is running? > > I uses the /usr/local/sin/sems.redhat start- to start the sems service? > Am > > I correct? > > My fifo name is same in both file that you mention. Please advice! > Thanks > > > > Regards, > > Shirley > > > > > -----Original Message----- > > > From: Ulrich Abend [SMTP:ullstar@iptel.org] > > > Sent: Wednesday, April 07, 2004 8:00 PM > > > To: serusers(a)lists.iptel.org > > > Cc: Shirley > > > Subject: Re: [Serusers] Sems Error > > > > > > Hi, > > > > > > you should make shure, SEMS is running and uses the same fifo name (in > > > sems.conf) as SER (in ser.cfg). > > > > > > It is also important, that the fifo file (default: /tmp/am_fifo) has > > > write > > > > > > permissions for the user SER runs as. The easiest setup is to run SER > and > > > SEMS as the same user. > > > > > > If you still experience problems, please post SER and SEMS debugging > > > output, > > > the config files, and the results of > > > ls -la /tmp/*fifo > > > > > > Regards, > > > > > > Uli. > > > > > > On Wednesday 07 April 2004 12:28, Shirley wrote: > > > > Hi all, > > > > > > > > Please Help!!! I am trying to install the sems when I try to start > the > > > > > > sems > > > > > > > I encountered this problem as per below. I am running on Linux 9.0 > and > > > > please also advice on how to check the fifo version....Thanks > > > > > > > > Mar 24 19:04:25 sipserver2 /usr/local/sbin/ser[12876]: ERROR: > > > > voicemail: ans_machine deamon is not running ! > > > > Mar 24 19:04:25 sipserver2 /usr/local/sbin/ser[12876]: ERROR: > > > > voicemail: > > > > > > No > > > > > > > such device or address > > > > Mar 24 19:04:25 sipserver2 /usr/local/sbin/ser[12876]: ERROR: > vm_start: > > > > write_to_fifo failed > > > > Mar 24 19:04:35 sipserver2 /usr/local/sbin/ser[12874]: ERROR: > > > > voicemail: ans_machine deamon is not running ! > > > > Mar 24 19:04:35 sipserver2 /usr/local/sbin/ser[12874]: ERROR: > > > > voicemail: > > > > > > No > > > > > > > such device or address > > > > Mar 24 19:04:35 sipserver2 /usr/local/sbin/ser[12874]: ERROR: > vm_start: > > > > write_to_fifo failed > > > > > > > > regards, > > > > shirley > > > > > > > > _______________________________________________ > > > > Serusers mailing list > > > > serusers(a)lists.iptel.org > > > > http://lists.iptel.org/mailman/listinfo/serusers

20 years, 10 months

[Serusers] problem installing latest ser distribution on Phedora/Linux

by goddess hekate

Hi, I am having a problem installing the latest ser distribution. This install is on a new server - Linux (Phedora) - Linux voice.x.com 2.4.22-2174.nptlsmp #1 SMP Wed Feb 18 16:21:50 EST 2004 Here is the command that I am running to set it up: #make all include_modules=mysql Here is the output of the command - Any help is greatly appreciated make[1]: Entering directory `/root/ser/sip_router/modules/mysql' gcc -fPIC -DPIC -g -O9 -funroll-loops -Wcast-align -Wall -minline-all-stringops -malign-double -falign-loops -mcpu=athlon -DNAME='"ser"' -DVERSION='"0.8.12-tcp_nonb"' -DARCH='"i386"' -DOS='"linux"' -DCOMPILER='"gcc 3.3"' -D__CPU_i386 -D__OS_linux -DCFG_DIR='"/usr/local/etc/ser/"' -DPKG_MALLOC -DSHM_MEM -DSHM_MMAP -DDNS_IP_HACK -DUSE_IPV6 -DUSE_TCP -DDISABLE_NAGLE -DF_MALLOC -DFAST_LOCK -DADAPTIVE_WAIT -DADAPTIVE_WAIT_LOOPS=1024 -DHAVE_GETHOSTBYNAME2 -DHAVE_UNION_SEMUN -DHAVE_SCHED_YIELD -DHAVE_MSG_NOSIGNAL -DHAVE_MSGHDR_MSG_CONTROL -I/usr/local/include -I/usr/local/include/mysql -I/usr/local/mysql/include -I/usr/pkg/include -c dbase.c -o dbase.o In file included from dbase.c:39: con_mysql.h:33:25: mysql/mysql.h: No such file or directory In file included from dbase.c:39: con_mysql.h:39: error: syntax error before "MYSQL_RES" con_mysql.h:39: warning: no semicolon at end of struct or union con_mysql.h:40: warning: type defaults to `int' in declaration of `con' con_mysql.h:40: warning: data definition has no type or storage class con_mysql.h:41: error: syntax error before "row" con_mysql.h:41: warning: type defaults to `int' in declaration of `row' con_mysql.h:41: warning: data definition has no type or storage class In file included from dbase.c:40: db_val.h:31:25: mysql/mysql.h: No such file or directory In file included from dbase.c:40: db_val.h:43: error: syntax error before '*' token dbase.c: In function `connect_db': dbase.c:89: error: dereferencing pointer to incomplete type dbase.c:89: error: `MYSQL' undeclared (first use in this function) dbase.c:89: error: (Each undeclared identifier is reported only once dbase.c:89: error: for each function it appears in.) dbase.c:89: error: syntax error before ')' token dbase.c:90: error: dereferencing pointer to incomplete type dbase.c:96: warning: implicit declaration of function `mysql_init' dbase.c:96: error: dereferencing pointer to incomplete type dbase.c:98: warning: implicit declaration of function `mysql_real_connect' dbase.c:98: error: dereferencing pointer to incomplete type dbase.c:99: warning: implicit declaration of function `mysql_error' dbase.c:99: error: dereferencing pointer to incomplete type dbase.c:99: error: dereferencing pointer to incomplete type dbase.c:99: warning: format argument is not a pointer (arg 3) dbase.c:99: error: dereferencing pointer to incomplete type dbase.c:99: warning: format argument is not a pointer (arg 3) dbase.c:99: error: dereferencing pointer to incomplete type dbase.c:99: warning: format argument is not a pointer (arg 3) dbase.c:99: error: dereferencing pointer to incomplete type dbase.c:99: warning: format argument is not a pointer (arg 3) dbase.c:99: error: dereferencing pointer to incomplete type dbase.c:99: warning: format argument is not a pointer (arg 3) dbase.c:99: error: dereferencing pointer to incomplete type dbase.c:99: warning: format argument is not a pointer (arg 3) dbase.c:99: error: dereferencing pointer to incomplete type dbase.c:99: warning: format argument is not a pointer (arg 3) dbase.c:100: warning: implicit declaration of function `mysql_close' dbase.c:100: error: dereferencing pointer to incomplete type dbase.c:102: error: dereferencing pointer to incomplete type dbase.c: In function `disconnect_db': dbase.c:127: error: dereferencing pointer to incomplete type dbase.c:129: error: dereferencing pointer to incomplete type dbase.c: In function `submit_query': dbase.c:151: warning: implicit declaration of function `mysql_query' dbase.c:151: error: dereferencing pointer to incomplete type dbase.c:152: error: dereferencing pointer to incomplete type dbase.c:152: error: dereferencing pointer to incomplete type dbase.c:152: warning: format argument is not a pointer (arg 3) dbase.c:152: error: dereferencing pointer to incomplete type dbase.c:152: warning: format argument is not a pointer (arg 3) dbase.c:152: error: dereferencing pointer to incomplete type dbase.c:152: warning: format argument is not a pointer (arg 3) dbase.c:152: error: dereferencing pointer to incomplete type dbase.c:152: warning: format argument is not a pointer (arg 3) dbase.c:152: error: dereferencing pointer to incomplete type dbase.c:152: warning: format argument is not a pointer (arg 3) dbase.c:152: error: dereferencing pointer to incomplete type dbase.c:152: warning: format argument is not a pointer (arg 3) dbase.c:152: error: dereferencing pointer to incomplete type dbase.c:152: warning: format argument is not a pointer (arg 3) dbase.c: At top level: dbase.c:187: error: syntax error before '*' token dbase.c: In function `print_values': dbase.c:191: error: `_c' undeclared (first use in this function) dbase.c:191: error: `_b' undeclared (first use in this function) dbase.c:191: error: `_l' undeclared (first use in this function) dbase.c:191: error: `_v' undeclared (first use in this function) dbase.c:191: error: `_n' undeclared (first use in this function) dbase.c: At top level: dbase.c:216: error: syntax error before '*' token dbase.c: In function `print_where': dbase.c:222: error: `_c' undeclared (first use in this function) dbase.c:222: error: `_b' undeclared (first use in this function) dbase.c:222: error: `_l' undeclared (first use in this function) dbase.c:222: error: `_k' undeclared (first use in this function) dbase.c:222: error: `_v' undeclared (first use in this function) dbase.c:222: error: `_n' undeclared (first use in this function) dbase.c:228: error: `_o' undeclared (first use in this function) dbase.c: At top level: dbase.c:247: error: syntax error before '*' token dbase.c: In function `print_set': dbase.c:253: error: `_c' undeclared (first use in this function) dbase.c:253: error: `_b' undeclared (first use in this function) dbase.c:253: error: `_l' undeclared (first use in this function) dbase.c:253: error: `_k' undeclared (first use in this function) dbase.c:253: error: `_v' undeclared (first use in this function) dbase.c:253: error: `_n' undeclared (first use in this function) dbase.c: In function `db_init': dbase.c:287: error: invalid application of `sizeof' to an incomplete type dbase.c:292: error: invalid application of `sizeof' to an incomplete type dbase.c:292: error: invalid application of `sizeof' to an incomplete type dbase.c:292: error: invalid application of `sizeof' to an incomplete type dbase.c:292: error: invalid application of `sizeof' to an incomplete type dbase.c:292: error: invalid application of `sizeof' to an incomplete type dbase.c:292: error: invalid application of `sizeof' to an incomplete type dbase.c: In function `db_close': dbase.c:318: error: dereferencing pointer to incomplete type dbase.c:319: warning: implicit declaration of function `mysql_free_result' dbase.c:319: error: dereferencing pointer to incomplete type dbase.c: In function `get_result': dbase.c:346: error: dereferencing pointer to incomplete type dbase.c:346: warning: implicit declaration of function `mysql_store_result' dbase.c:346: error: dereferencing pointer to incomplete type dbase.c:347: error: dereferencing pointer to incomplete type dbase.c:348: warning: implicit declaration of function `mysql_field_count' dbase.c:348: error: dereferencing pointer to incomplete type dbase.c:353: error: dereferencing pointer to incomplete type dbase.c:353: error: dereferencing pointer to incomplete type dbase.c:353: warning: format argument is not a pointer (arg 3) dbase.c:353: error: dereferencing pointer to incomplete type dbase.c:353: warning: format argument is not a pointer (arg 3) dbase.c:353: error: dereferencing pointer to incomplete type dbase.c:353: warning: format argument is not a pointer (arg 3) dbase.c:353: error: dereferencing pointer to incomplete type dbase.c:353: warning: format argument is not a pointer (arg 3) dbase.c:353: error: dereferencing pointer to incomplete type dbase.c:353: warning: format argument is not a pointer (arg 3) dbase.c:353: error: dereferencing pointer to incomplete type dbase.c:353: warning: format argument is not a pointer (arg 3) dbase.c:353: error: dereferencing pointer to incomplete type dbase.c:353: warning: format argument is not a pointer (arg 3) dbase.c: In function `db_free_query': dbase.c:391: error: dereferencing pointer to incomplete type dbase.c:392: error: dereferencing pointer to incomplete type dbase.c: In function `db_query': dbase.c:428: error: dereferencing pointer to incomplete type dbase.c: In function `db_insert': dbase.c:484: error: dereferencing pointer to incomplete type dbase.c: In function `db_delete': dbase.c:516: error: dereferencing pointer to incomplete type dbase.c: In function `db_update': dbase.c:548: error: dereferencing pointer to incomplete type dbase.c:551: error: dereferencing pointer to incomplete type make[1]: *** [dbase.o] Error 1 make[1]: Leaving directory `/root/ser/sip_router/modules/mysql' _________________________________________________________________ FREE pop-up blocking with the new MSN Toolbar get it now! http://toolbar.msn.com/go/onm00200415ave/direct/01/

20 years, 10 months

[Serusers] need advise

by Vitaly Nikolaev

Hello, I am trying to add Remote-Party-ID dynamicly. In my config I use exec_dst for routing and aliases and because of this I can not use append_rpid function (it need saved SIP URI exists... and i do not knwo where to get it) I am planing to write short function exec_rpid that will do this work.. please tell me if it is good idea or I will just waste my time and there are ready solutions for this ? Thxs

20 years, 10 months

[Serusers] routing question

by Vitaly Nikolaev

Hello, I have small problem with dinamic routing.. my config looks like: (page down) as u see i have two steps routing.. second exec_dset return me uri of voicemail or it could be another number. the question is: how can i do rtp_proxy on second step ? i can not just put force_rtp_proxy(); in failure_route.. it is not allowed.... Please help short version: route { if (nat_uac_test("2")) { xlog("L_ALERT", "(%ci) src address different than via header->NAT detected"); force_rport(); fix_nated_contact(); setflag(5); } if(uri==myself) { exec_dset("/usr/local/ser/bin/getroute"); route(1); } } route [1] { xlog("L_ALERT", "(%ci) entering route[1] - relaying SIP message to online user\n"); if ((isflagset(5)) || (isflagset(6))) { xlog("L_ALERT", "(%ci) at least one of the participants is NATed->record_route\n"); record_route(); xlog("L_ALERT", "(%ci) -->setting up reply processing ->onreply_route[1]"); t_on_reply("1"); if (method=="INVITE") { xlog("L_ALERT", "(%ci) INVITE request-->force_rtp_proxy, set NATED-INVITE flag(7)"); force_rtp_proxy(); append_hf("P-hint: request forced to rtp proxy\r\n"); setflag(7); }; }; t_on_failure("1"); xlog("L_ALERT", "(%ci) relaying message ...(%tu)"); if (!t_relay()) { xlog("L_ALERT", "(%ci) t_relay error occured\n"); sl_reply_error(); }; } onreply_route[1] { xlog("L_ALERT", "(%ci) onreply_route[1] entered\n"); if ( (status=~"200" || status=~"183") ) { xlog("L_ALERT", "(%ci) status 2xx or 183"); if ( isflagset(7) ) { xlog("L_ALERT", "(%ci) marked(7) as NATED-INVITE -> force_rtp_proxy \n"); force_rtp_proxy(); append_hf("P-hint: response forced to rtp proxy\r\n"); }; }; } failure_route[3] { /* XX: note: unsafe if preloaded routes without username used */ xlog("L_ALERT", "(%ci) failureroute[1] entered\"); exec_dset("/usr/local/ser/bin/getroute vm"); t_on_failure("4"); xlog("L_ALERT", "(%ci) relaying message ...(%tu)"); append_branch(); if (!t_relay()) { xlog("L_ALERT", "(%ci) t_relay error occured\n"); # sl_reply_error(); }; }

20 years, 10 months

[Serusers] is it possible to use variables in ser.cfg

by siva kumar

hi frineds, is it possible to use variables in ser.cfg, is it possible to use control structures in ser.cfg. anybody help me. thank u _________________________________________________________________ Buzz on your screen! Download on your screen. http://www.msn.co.in/Download/screensaver/ Keep yourself smiling!

20 years, 10 months

RE: [Serusers] Not Recognizing ACK

by Mike Morrison

The ACK came .0784 seconds after the 503 was returned according to the ethereal dump. Mike -----Original Message----- From: Jan Janak [mailto:jan@iptel.org] Sent: Tuesday, April 06, 2004 5:21 PM To: Mike Morrison Cc: 'serusers(a)lists.iptel.org' Subject: Re: [Serusers] Not Recognizing ACK Are you sure that the ACK comes no later than 2 seconds after 503 is sent ? Jan. On 05-04 13:28, Mike Morrison wrote: > Running SER 0.8.12 on Solaris 8 -SPARC with MySQL installed. > > > > The issue that I'm running into is that when the originating GW receives a > response and generates an ACK the SER doesn't seem to stop the timer for > resending the message. If you look in the log, you can see where the server > receives it, but the server resends the same response as if the ACK was > ignored. It the attached case a 503 response is sent back, but the same > situation occurs when other responses are sent. > > > > Thanks, Mike > > > > Script started on Tue 30 Mar 2004 04:56:58 PM CST > # /usr/local/sbin/ser > 0(29441) loading module /usr/local/lib/ser/modules/mysql.so > 0(29441) loading module /usr/local/lib/ser/modules/sl.so > 0(29441) loading module /usr/local/lib/ser/modules/tm.so > 0(29441) loading module /usr/local/lib/ser/modules/rr.so > 0(29441) loading module /usr/local/lib/ser/modules/maxfwd.so > 0(29441) loading module /usr/local/lib/ser/modules/usrloc.so > 0(29441) loading module /usr/local/lib/ser/modules/registrar.so > 0(29441) set_mod_param_regex: usrloc matches module usrloc > 0(29441) set_mod_param_regex: found <db_mode> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) set_mod_param_regex: rr matches module rr > 0(29441) set_mod_param_regex: found <enable_full_lr> in module rr [/usr/local/lib/ser/modules/rr.so] > 0(29441) find_export: found <mf_process_maxfwd_header> in module maxfwd_module [/usr/local/lib/ser/modules/maxfwd.so] > 0(29441) find_export: found <sl_send_reply> in module sl_module [/usr/local/lib/ser/modules/sl.so] > 0(29441) find_export: found <sl_send_reply> in module sl_module [/usr/local/lib/ser/modules/sl.so] > 0(29441) find_export: found <record_route> in module rr [/usr/local/lib/ser/modules/rr.so] > 0(29441) find_export: found <sl_send_reply> in module sl_module [/usr/local/lib/ser/modules/sl.so] > 0(29441) find_export: found <t_relay> in module tm [/usr/local/lib/ser/modules/tm.so] > 0(29441) find_export: found <sl_reply_error> in module sl_module [/usr/local/lib/ser/modules/sl.so] > 0(29441) routing table 0: > 0(29441) if ( 0(29441) NOT( 0(29441) external_module_call( 0(29441) f_ptr<fcf20ca0> 0(29441) , "10" 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<fcf20ca0> 0(29441) , "10" 0(29441) ); 0(29441) ) 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518c0> 0(29441) , "483" 0(29441) , "Too Many Hops" 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) UNKNOWN 0(29441) <UNKNOWN> 0(29441) 65535 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518c0> 0(29441) , "513" 0(29441) , "Message too big" 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) external_module_call( 0(29441) f_ptr<fcf435e0> 0(29441) ); 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "REGISTER" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED REGISTER ****************************** > " 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<ff1518c0> 0(29441) , "200" 0(29441) , "ok" 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "OPTIONS" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED OPTIONS MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INFO" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED INFO MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "CANCEL" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED CANCEL MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "ACK" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED ACK *********************************** > " 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INVITE" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED INVITE ******************************** > " 0(29441) ); 0(29441) sethostport( 0(29441) "10.31.15.253:4000" 0(29441) ); 0(29441) if ( 0(29441) NOT( 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) ) 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518e0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) UNKNOWN 0(29441) <UNKNOWN> 0(29441) 65535 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518c0> 0(29441) , "513" 0(29441) , "Message too big" 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) external_module_call( 0(29441) f_ptr<fcf435e0> 0(29441) ); 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "REGISTER" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED REGISTER ****************************** > " 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<ff1518c0> 0(29441) , "200" 0(29441) , "ok" 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "OPTIONS" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED OPTIONS MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INFO" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED INFO MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "CANCEL" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED CANCEL MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "ACK" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED ACK *********************************** > " 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INVITE" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED INVITE ******************************** > " 0(29441) ); 0(29441) sethostport( 0(29441) "10.31.15.253:4000" 0(29441) ); 0(29441) if ( 0(29441) NOT( 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) ) 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518e0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) } else { 0(29441) }; 0(29441) external_module_call( 0(29441) f_ptr<fcf435e0> 0(29441) ); 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "REGISTER" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED REGISTER ****************************** > " 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<ff1518c0> 0(29441) , "200" 0(29441) , "ok" 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "OPTIONS" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED OPTIONS MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INFO" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED INFO MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "CANCEL" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED CANCEL MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "ACK" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED ACK *********************************** > " 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INVITE" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED INVITE ******************************** > " 0(29441) ); 0(29441) sethostport( 0(29441) "10.31.15.253:4000" 0(29441) ); 0(29441) if ( 0(29441) NOT( 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) ) 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518e0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "REGISTER" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED REGISTER ****************************** > " 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<ff1518c0> 0(29441) , "200" 0(29441) , "ok" 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "OPTIONS" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED OPTIONS MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INFO" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED INFO MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "CANCEL" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED CANCEL MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "ACK" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED ACK *********************************** > " 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INVITE" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED INVITE ******************************** > " 0(29441) ); 0(29441) sethostport( 0(29441) "10.31.15.253:4000" 0(29441) ); 0(29441) if ( 0(29441) NOT( 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) ) 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518e0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "OPTIONS" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED OPTIONS MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INFO" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED INFO MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "CANCEL" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED CANCEL MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "ACK" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED ACK *********************************** > " 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INVITE" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED INVITE ******************************** > " 0(29441) ); 0(29441) sethostport( 0(29441) "10.31.15.253:4000" 0(29441) ); 0(29441) if ( 0(29441) NOT( 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) ) 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518e0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INFO" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED INFO MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "CANCEL" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED CANCEL MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "ACK" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED ACK *********************************** > " 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INVITE" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED INVITE ******************************** > " 0(29441) ); 0(29441) sethostport( 0(29441) "10.31.15.253:4000" 0(29441) ); 0(29441) if ( 0(29441) NOT( 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) ) 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518e0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "CANCEL" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "********************* RECEIVED CANCEL MESSAGE **************************** > " 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "ACK" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED ACK *********************************** > " 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INVITE" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED INVITE ******************************** > " 0(29441) ); 0(29441) sethostport( 0(29441) "10.31.15.253:4000" 0(29441) ); 0(29441) if ( 0(29441) NOT( 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) ) 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518e0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "ACK" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED ACK *********************************** > " 0(29441) ); 0(29441) drop( 0(29441) type<0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INVITE" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED INVITE ******************************** > " 0(29441) ); 0(29441) sethostport( 0(29441) "10.31.15.253:4000" 0(29441) ); 0(29441) if ( 0(29441) NOT( 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) ) 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518e0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) } else { 0(29441) }; 0(29441) if ( 0(29441) method 0(29441) == 0(29441) "INVITE" 0(29441) ) { 0(29441) log( 0(29441) 1 0(29441) , "************************** RECEIVED INVITE ******************************** > " 0(29441) ); 0(29441) sethostport( 0(29441) "10.31.15.253:4000" 0(29441) ); 0(29441) if ( 0(29441) NOT( 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) external_module_call( 0(29441) f_ptr<fcf79e00> 0(29441) ); 0(29441) ) 0(29441) ) { 0(29441) external_module_call( 0(29441) f_ptr<ff1518e0> 0(29441) ); 0(29441) } else { 0(29441) }; 0(29441) } else { 0(29441) }; 0(29441) > Listening on > 10.31.14.200 [10.31.14.200]:5060 > Aliases: loghost:5060 caveman:5060 > WARNING: no fork mode > 0(29441) DEBUG: init_mod: mysql > 0(29441) mysql - initializing > 0(29441) DEBUG: init_mod: sl_module > stateless - initializing > 0(29441) DEBUG: register_fifo_cmd: new command (sl_stats) registered > 0(29441) DEBUG: MD5 calculated: 9c818f52bcc4fffa9610568f4be52539 > 0(29441) DEBUG: init_mod: tm > 0(29441) TM - initializing... > 0(29441) Call-ID initialization: '58282eed' > 0(29441) DEBUG: register_fifo_cmd: new command (t_uac_dlg) registered > 0(29441) DEBUG: register_fifo_cmd: new command (t_hash) registered > 0(29441) DEBUG: lock_initialize: lock initialization started > 0(29441) DEBUG: register_fifo_cmd: new command (t_stats) registered > 0(29441) Warning: uac does not spread accross the whole hash table > 0(29441) DEBUG: MD5 calculated: 6846af86154c482b36472261b1d13258 > 0(29441) DEBUG: MD5 calculated: 19d4d767dedba5e9d0a57f60eb631aa7 > 0(29441) DEBUG: init_mod: rr > 0(29441) rr - initializing > 0(29441) DEBUG: init_mod: maxfwd_module > Maxfwd module- initializing > 0(29441) DEBUG: init_mod: usrloc > 0(29441) usrloc - initializing > 0(29441) DEBUG: register_fifo_cmd: new command (ul_stats) registered > 0(29441) DEBUG: register_fifo_cmd: new command (ul_rm) registered > 0(29441) DEBUG: register_fifo_cmd: new command (ul_rm_contact) registered > 0(29441) DEBUG: register_fifo_cmd: new command (ul_dump) registered > 0(29441) DEBUG: register_fifo_cmd: new command (ul_flush) registered > 0(29441) DEBUG: register_fifo_cmd: new command (ul_add) registered > 0(29441) DEBUG: register_fifo_cmd: new command (ul_show_contact) registered > 0(29441) find_export: found <db_use_table> in module mysql [/usr/local/lib/ser/modules/mysql.so] > 0(29441) find_export: found <db_init> in module mysql [/usr/local/lib/ser/modules/mysql.so] > 0(29441) find_export: found <db_close> in module mysql [/usr/local/lib/ser/modules/mysql.so] > 0(29441) find_export: found <db_query> in module mysql [/usr/local/lib/ser/modules/mysql.so] > 0(29441) find_export: found <db_raw_query> in module mysql [/usr/local/lib/ser/modules/mysql.so] > 0(29441) find_export: found <db_free_query> in module mysql [/usr/local/lib/ser/modules/mysql.so] > 0(29441) find_export: found <db_insert> in module mysql [/usr/local/lib/ser/modules/mysql.so] > 0(29441) find_export: found <db_delete> in module mysql [/usr/local/lib/ser/modules/mysql.so] > 0(29441) find_export: found <db_update> in module mysql [/usr/local/lib/ser/modules/mysql.so] > 0(29441) mod_init(): Database connection opened successfuly > 0(29441) DEBUG: init_mod: registrar > 0(29441) registrar - initializing > 0(29441) find_export: found <sl_send_reply> in module sl_module [/usr/local/lib/ser/modules/sl.so] > 0(29441) find_export: found <ul_bind_usrloc> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_register_udomain> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_get_all_ucontacts> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_insert_urecord> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_delete_urecord> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_get_urecord> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_lock_udomain> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_unlock_udomain> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_release_urecord> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_insert_ucontact> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_delete_ucontact> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_get_ucontact> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(29441) find_export: found <ul_update_ucontact> in module usrloc [/usr/local/lib/ser/modules/usrloc.so] > 0(0) fixing /usr/local/lib/ser/modules/maxfwd.so mf_process_maxfwd_header > 0(0) fixing /usr/local/lib/ser/modules/sl.so sl_send_reply > 0(0) fixing /usr/local/lib/ser/modules/sl.so sl_send_reply > 0(0) fixing /usr/local/lib/ser/modules/rr.so record_route > 0(0) fixing /usr/local/lib/ser/modules/sl.so sl_send_reply > 0(0) fixing /usr/local/lib/ser/modules/tm.so t_relay > 0(0) fixing /usr/local/lib/ser/modules/sl.so sl_reply_error > 0(0) INFO: udp_init: SO_RCVBUF is initially 8192 > 0(0) DEBUG: udp_init: trying SO_RCVBUF: 16384 > 0(0) DEBUG: setting SO_RCVBUF; set=16384,verify=16384 > 0(0) DEBUG: udp_init: trying SO_RCVBUF: 32768 > 0(0) DEBUG: setting SO_RCVBUF; set=32768,verify=32768 > 0(0) DEBUG: udp_init: trying SO_RCVBUF: 65536 > 0(0) DEBUG: setting SO_RCVBUF; set=65536,verify=65536 > 0(0) DEBUG: udp_init: trying SO_RCVBUF: 131072 > 0(0) DEBUG: setting SO_RCVBUF; set=131072,verify=131072 > 0(0) DEBUG: udp_init: trying SO_RCVBUF: 262144 > 0(0) DEBUG: setting SO_RCVBUF; set=262144,verify=262144 > 0(0) INFO: udp_init: SO_RCVBUF is finally 262144 > 1(0) DEBUG: init_mod_child (-1): tm > 1(0) DEBUG: callid: '58282eed-0(a)10.31.14.200' > 1(0) DEBUG: init_mod_child (-1): usrloc > 1(29442) DBG: open_uac_fifo: opening fifo... > 1(29442) DEBUG: open_fifo_server: FIFO stat failed: Error 0 > 1(29442) DEBUG: FIFO created @ /tmp/ser_fifo > 1(29442) DEBUG: fifo /tmp/ser_fifo opened, mode=432 > 2(0) INFO: fifo process starting: 29443 > 2(0) DEBUG: init_mod_child (-2): tm > 2(0) DEBUG: callid: '58282eed-0(a)10.31.14.200' > 2(0) DEBUG: init_mod_child (-2): usrloc > 2(29443) SER: open_uac_fifo: fifo server up at /tmp/ser_fifo... > 0(29441) DEBUG: init_mod_child (1): tm > 0(29441) DEBUG: callid: '58282eed-29441(a)10.31.14.200' > 0(29441) DEBUG: init_mod_child (1): usrloc > 0(29441) SIP Request: > 0(29441) method: <INVITE> > 0(29441) uri: <sip:5551111234@10.31.14.200;dtg=LAB_LA_TERM> > 0(29441) version: <SIP/2.0> > 0(29441) parse_headers: flags=1 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=1 > 0(29441) parse_headers: this is the first via > 0(29441) After parse_msg... > 0(29441) preparing to run routing scripts... > 0(29441) DEBUG : is_maxfwd_present: searching for max_forwards header > 0(29441) parse_headers: flags=128 > 0(29441) end of header reached, state=9 > 0(29441) DEBUG: get_hdr_field: <To> [36]; uri=[sip:5551111234@10.31.14.200:5060] > 0(29441) DEBUG: to body [<sip:5551111234@10.31.14.200:5060> > ] > 0(29441) get_hdr_field: cseq <CSeq>: <3267> <INVITE> > 0(29441) DEBUG: get_hdr_body : content_length=152 > 0(29441) found end of header > 0(29441) DEBUG: is_maxfwd_present: max_forwards header not found! > 0(29441) DEBUG: add_param: pstn-params=808182808882 > 0(29441) DEBUG: add_param: tag=72 > 0(29441) end of header reached, state=29 > 0(29441) ************************** RECEIVED INVITE ******************************** > 0(29441) DEBUG: t_addifnew: msg id=1 , global msg id=0 , T on entrance=ffffffff > 0(29441) parse_headers: flags=-1 > 0(29441) parse_headers: flags=60 > 0(29441) t_lookup_request: start searching: hash=35190, isACK=0 > 0(29441) DEBUG: proceeding to pre-RFC3261 transaction matching > 0(29441) DEBUG: t_lookup_request: no transaction found > 0(29441) SER: new INVITE > 0(29441) parse_headers: flags=-1 > 0(29441) check_via_address(10.31.14.253, 10.31.14.253, 0) > 0(29441) WARNING:vqm_resize: resize(0) called > 0(29441) DEBUG: reply sent out. buf=9c390: SIP/2.0 1..., shmem=fd184a28: SIP/2.0 1 > 0(29441) DEBUG: t_reply: finished > 0(29441) DEBUG: mk_proxy: doing DNS lookup... > 0(29441) check_via_address(10.31.14.253, 10.31.14.253, 0) > 0(29441) DEBUG: add_to_tail_of_timer[4]: fd18332c > 0(29441) DEBUG: add_to_tail_of_timer[0]: fd183340 > 0(29441) SER: new transaction fwd'ed > 0(29441) receive_msg: cleaning up > 0(29441) SIP Reply (status): > 0(29441) version: <SIP/2.0> > 0(29441) status: <100> > 0(29441) reason: <Trying> > 0(29441) parse_headers: flags=1 > 0(29441) Found param type 232, <branch> = <z9hG4bK6798.3d17.0>; state=16 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=1 > 0(29441) parse_headers: this is the first via > 0(29441) After parse_msg... > 0(29441) check_self - checking if host==us: 12==12 && [10.31.14.200] == [10.31.14.200] > 0(29441) check_self - checking if port 5060 matches port 5060 > 0(29441) forward_reply: found module tm, passing reply to it > 0(29441) DEBUG: t_check: msg id=2 global id=1 T start=ffffffff > 0(29441) parse_headers: flags=17 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=17 > 0(29441) parse_headers: this is the second via > 0(29441) DEBUG: add_param: tag=61 > 0(29441) end of header reached, state=29 > 0(29441) DEBUG: get_hdr_field: <To> [43]; uri=[sip:5551111234@10.31.14.200:5060] > 0(29441) DEBUG: to body [<sip:5551111234@10.31.14.200:5060>] > 0(29441) get_hdr_field: cseq <CSeq>: <3267> <INVITE> > 0(29441) parse_headers: flags=4 > 0(29441) DEBUG: t_reply_matching: hash 35190 label 29139 branch 0 > 0(29441) DEBUG: t_reply_matching: reply matched (T=fd183200)! > 0(29441) DEBUG: t_check: msg id=2 global id=2 T end=fd183200 > 0(29441) DEBUG: t_on_reply: org. status uas=100, uac[0]=0 local=0 is_invite=1) > 0(29441) ->>>>>>>>> T_code=100, new_code=100 > 0(29441) DEBUG: relay_reply: branch=0, save=0, relay=-1 > 0(29441) DEBUG: add_to_tail_of_timer[1]: fd183340 > 0(29441) receive_msg: cleaning up > 0(29441) SIP Reply (status): > 0(29441) version: <SIP/2.0> > 0(29441) status: <503> > 0(29441) reason: <Service Unavailable> > 0(29441) parse_headers: flags=1 > 0(29441) Found param type 232, <branch> = <z9hG4bK6798.3d17.0>; state=16 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=1 > 0(29441) parse_headers: this is the first via > 0(29441) After parse_msg... > 0(29441) check_self - checking if host==us: 12==12 && [10.31.14.200] == [10.31.14.200] > 0(29441) check_self - checking if port 5060 matches port 5060 > 0(29441) forward_reply: found module tm, passing reply to it > 0(29441) DEBUG: t_check: msg id=3 global id=2 T start=ffffffff > 0(29441) parse_headers: flags=17 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=17 > 0(29441) parse_headers: this is the second via > 0(29441) DEBUG: add_param: tag=61 > 0(29441) end of header reached, state=29 > 0(29441) DEBUG: get_hdr_field: <To> [43]; uri=[sip:5551111234@10.31.14.200:5060] > 0(29441) DEBUG: to body [<sip:5551111234@10.31.14.200:5060>] > 0(29441) get_hdr_field: cseq <CSeq>: <3267> <INVITE> > 0(29441) parse_headers: flags=4 > 0(29441) DEBUG: t_reply_matching: hash 35190 label 29139 branch 0 > 0(29441) DEBUG: t_reply_matching: reply matched (T=fd183200)! > 0(29441) DEBUG: t_check: msg id=3 global id=3 T end=fd183200 > 0(29441) DEBUG: t_on_reply: org. status uas=100, uac[0]=100 local=0 is_invite=1) > 0(29441) parse_headers: flags=4 > 0(29441) ->>>>>>>>> T_code=100, new_code=503 > 0(29441) DEBUG: relay_reply: branch=0, save=0, relay=0 > 0(29441) old size: 385, new size: 328 > 0(29441) build_res_from_sip_res: copied size: orig:90, new: 33, rest: 295 msg= > SIP/2.0 503 Service Unavailable > Via: SIP/2.0/UDP 10.31.14.253:4000 > From: <sip:5127351243@10.31.14.253:4000>;pstn-params=808182808882;tag=72 > To: <sip:5551111234@10.31.14.200:5060>;tag=61 > Call-ID: 947552_97051161(a)10.31.14.253 > CSeq: 3267 INVITE > Record-Route: <sip:5551111234@10.31.14.200;ftag=72;lr=on> > Content-Length: 0 > > > 0(29441) DEBUG: reply relayed. buf=9c5d0: SIP/2.0 5..., shmem=fd1850e0: SIP/2.0 5 > 0(29441) DEBUG: cleanup_uacs: RETR/FR timers reset > 0(29441) DEBUG: add_to_tail_of_timer[4]: fd1832b4 > 0(29441) DEBUG: add_to_tail_of_timer[0]: fd1832c8 > 0(29441) receive_msg: cleaning up > 0(29441) SIP Request: > 0(29441) method: <ACK> > 0(29441) uri: <sip:5551111234@10.31.14.200> > 0(29441) version: <SIP/2.0> > 0(29441) parse_headers: flags=1 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=1 > 0(29441) parse_headers: this is the first via > 0(29441) After parse_msg... > 0(29441) DEBUG : sl_filter_ACK: to late to be a local ACK! > 0(29441) preparing to run routing scripts... > 0(29441) DEBUG : is_maxfwd_present: searching for max_forwards header > 0(29441) parse_headers: flags=128 > 0(29441) DEBUG: add_param: tag=61 > 0(29441) end of header reached, state=29 > 0(29441) DEBUG: get_hdr_field: <To> [43]; uri=[sip:5551111234@10.31.14.200:5060] > 0(29441) DEBUG: to body [<sip:5551111234@10.31.14.200:5060>] > 0(29441) get_hdr_field: cseq <CSeq>: <3267> <ACK> > 0(29441) DEBUG: get_hdr_body : content_length=0 > 0(29441) found end of header > 0(29441) DEBUG: is_maxfwd_present: max_forwards header not found! > 0(29441) DEBUG: add_param: pstn-params=808182808882 > 0(29441) DEBUG: add_param: tag=72 > 0(29441) end of header reached, state=29 > 0(29441) ************************** RECEIVED ACK *********************************** > 0(29441) receive_msg: cleaning up > 1(29442) DEBUG: timer routine:1,tl=fd183340 next=0 > 1(29442) DEBUG: timer routine:4,tl=fd18332c next=fd1832b4 > 1(29442) DEBUG: timer routine:4,tl=fd1832b4 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd183200, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd1850e0: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[5]: fd1832b4 > 1(29442) DEBUG: retransmission_handler : done > 0(29441) SIP Request: > 0(29441) method: <INVITE> > 0(29441) uri: <sip:5551111235@10.31.14.200;dtg=LAB_LA_TERM> > 0(29441) version: <SIP/2.0> > 0(29441) parse_headers: flags=1 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=1 > 0(29441) parse_headers: this is the first via > 0(29441) After parse_msg... > 0(29441) preparing to run routing scripts... > 0(29441) DEBUG : is_maxfwd_present: searching for max_forwards header > 0(29441) parse_headers: flags=128 > 0(29441) end of header reached, state=9 > 0(29441) DEBUG: get_hdr_field: <To> [36]; uri=[sip:5551111235@10.31.14.200:5060] > 0(29441) DEBUG: to body [<sip:5551111235@10.31.14.200:5060> > ] > 0(29441) get_hdr_field: cseq <CSeq>: <5023> <INVITE> > 0(29441) DEBUG: get_hdr_body : content_length=152 > 0(29441) found end of header > 0(29441) DEBUG: is_maxfwd_present: max_forwards header not found! > 0(29441) DEBUG: add_param: pstn-params=808182808882 > 0(29441) DEBUG: add_param: tag=72 > 0(29441) end of header reached, state=29 > 0(29441) ************************** RECEIVED INVITE ******************************** > 0(29441) DEBUG: t_addifnew: msg id=5 , global msg id=3 , T on entrance=ffffffff > 0(29441) parse_headers: flags=-1 > 0(29441) parse_headers: flags=60 > 0(29441) t_lookup_request: start searching: hash=48741, isACK=0 > 0(29441) DEBUG: proceeding to pre-RFC3261 transaction matching > 0(29441) DEBUG: t_lookup_request: no transaction found > 0(29441) SER: new INVITE > 0(29441) parse_headers: flags=-1 > 0(29441) check_via_address(10.31.14.253, 10.31.14.253, 0) > 0(29441) WARNING:vqm_resize: resize(0) called > 0(29441) DEBUG: reply sent out. buf=9c728: SIP/2.0 1..., shmem=fd184a28: SIP/2.0 1 > 0(29441) DEBUG: t_reply: finished > 0(29441) DEBUG: mk_proxy: doing DNS lookup... > 0(29441) check_via_address(10.31.14.253, 10.31.14.253, 0) > 0(29441) DEBUG: add_to_tail_of_timer[4]: fd18538c > 0(29441) DEBUG: add_to_tail_of_timer[0]: fd1853a0 > 0(29441) SER: new transaction fwd'ed > 0(29441) receive_msg: cleaning up > 0(29441) SIP Reply (status): > 0(29441) version: <SIP/2.0> > 0(29441) status: <100> > 0(29441) reason: <Trying> > 0(29441) parse_headers: flags=1 > 0(29441) Found param type 232, <branch> = <z9hG4bK56eb.77a1.0>; state=16 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=1 > 0(29441) parse_headers: this is the first via > 0(29441) After parse_msg... > 0(29441) check_self - checking if host==us: 12==12 && [10.31.14.200] == [10.31.14.200] > 0(29441) check_self - checking if port 5060 matches port 5060 > 0(29441) forward_reply: found module tm, passing reply to it > 0(29441) DEBUG: t_check: msg id=6 global id=5 T start=ffffffff > 0(29441) parse_headers: flags=17 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=17 > 0(29441) parse_headers: this is the second via > 0(29441) DEBUG: add_param: tag=61 > 0(29441) end of header reached, state=29 > 0(29441) DEBUG: get_hdr_field: <To> [43]; uri=[sip:5551111235@10.31.14.200:5060] > 0(29441) DEBUG: to body [<sip:5551111235@10.31.14.200:5060>] > 0(29441) get_hdr_field: cseq <CSeq>: <5023> <INVITE> > 0(29441) parse_headers: flags=4 > 0(29441) DEBUG: t_reply_matching: hash 48741 label 6775 branch 0 > 0(29441) DEBUG: t_reply_matching: reply matched (T=fd185260)! > 0(29441) DEBUG: t_check: msg id=6 global id=6 T end=fd185260 > 0(29441) DEBUG: t_on_reply: org. status uas=100, uac[0]=0 local=0 is_invite=1) > 0(29441) ->>>>>>>>> T_code=100, new_code=100 > 0(29441) DEBUG: relay_reply: branch=0, save=0, relay=-1 > 0(29441) DEBUG: add_to_tail_of_timer[1]: fd1853a0 > 0(29441) receive_msg: cleaning up > 0(29441) SIP Reply (status): > 0(29441) version: <SIP/2.0> > 0(29441) status: <503> > 0(29441) reason: <Service Unavailable> > 0(29441) parse_headers: flags=1 > 0(29441) Found param type 232, <branch> = <z9hG4bK56eb.77a1.0>; state=16 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=1 > 0(29441) parse_headers: this is the first via > 0(29441) After parse_msg... > 0(29441) check_self - checking if host==us: 12==12 && [10.31.14.200] == [10.31.14.200] > 0(29441) check_self - checking if port 5060 matches port 5060 > 0(29441) forward_reply: found module tm, passing reply to it > 0(29441) DEBUG: t_check: msg id=7 global id=6 T start=ffffffff > 0(29441) parse_headers: flags=17 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=17 > 0(29441) parse_headers: this is the second via > 0(29441) DEBUG: add_param: tag=61 > 0(29441) end of header reached, state=29 > 0(29441) DEBUG: get_hdr_field: <To> [43]; uri=[sip:5551111235@10.31.14.200:5060] > 0(29441) DEBUG: to body [<sip:5551111235@10.31.14.200:5060>] > 0(29441) get_hdr_field: cseq <CSeq>: <5023> <INVITE> > 0(29441) parse_headers: flags=4 > 0(29441) DEBUG: t_reply_matching: hash 48741 label 6775 branch 0 > 0(29441) DEBUG: t_reply_matching: reply matched (T=fd185260)! > 0(29441) DEBUG: t_check: msg id=7 global id=7 T end=fd185260 > 0(29441) DEBUG: t_on_reply: org. status uas=100, uac[0]=100 local=0 is_invite=1) > 0(29441) parse_headers: flags=4 > 0(29441) ->>>>>>>>> T_code=100, new_code=503 > 0(29441) DEBUG: relay_reply: branch=0, save=0, relay=0 > 0(29441) old size: 385, new size: 328 > 0(29441) build_res_from_sip_res: copied size: orig:90, new: 33, rest: 295 msg= > SIP/2.0 503 Service Unavailable > Via: SIP/2.0/UDP 10.31.14.253:4000 > From: <sip:5127351244@10.31.14.253:4000>;pstn-params=808182808882;tag=72 > To: <sip:5551111235@10.31.14.200:5060>;tag=61 > Call-ID: 947553_97051261(a)10.31.14.253 > CSeq: 5023 INVITE > Record-Route: <sip:5551111235@10.31.14.200;ftag=72;lr=on> > Content-Length: 0 > > > 0(29441) DEBUG: reply relayed. buf=9c5d0: SIP/2.0 5..., shmem=fd186e60: SIP/2.0 5 > 0(29441) DEBUG: cleanup_uacs: RETR/FR timers reset > 0(29441) DEBUG: add_to_tail_of_timer[4]: fd185314 > 0(29441) DEBUG: add_to_tail_of_timer[0]: fd185328 > 0(29441) receive_msg: cleaning up > 0(29441) SIP Request: > 0(29441) method: <ACK> > 0(29441) uri: <sip:5551111235@10.31.14.200> > 0(29441) version: <SIP/2.0> > 0(29441) parse_headers: flags=1 > 0(29441) end of header reached, state=5 > 0(29441) parse_headers: Via found, flags=1 > 0(29441) parse_headers: this is the first via > 0(29441) After parse_msg... > 0(29441) DEBUG : sl_filter_ACK: to late to be a local ACK! > 0(29441) preparing to run routing scripts... > 0(29441) DEBUG : is_maxfwd_present: searching for max_forwards header > 0(29441) parse_headers: flags=128 > 0(29441) DEBUG: add_param: tag=61 > 0(29441) end of header reached, state=29 > 0(29441) DEBUG: get_hdr_field: <To> [43]; uri=[sip:5551111235@10.31.14.200:5060] > 0(29441) DEBUG: to body [<sip:5551111235@10.31.14.200:5060>] > 0(29441) get_hdr_field: cseq <CSeq>: <5023> <ACK> > 0(29441) DEBUG: get_hdr_body : content_length=0 > 0(29441) found end of header > 0(29441) DEBUG: is_maxfwd_present: max_forwards header not found! > 0(29441) DEBUG: add_param: pstn-params=808182808882 > 0(29441) DEBUG: add_param: tag=72 > 0(29441) end of header reached, state=29 > 0(29441) ************************** RECEIVED ACK *********************************** > 0(29441) receive_msg: cleaning up > 1(29442) DEBUG: timer routine:1,tl=fd1853a0 next=0 > 1(29442) DEBUG: timer routine:4,tl=fd18538c next=fd185314 > 1(29442) DEBUG: timer routine:4,tl=fd185314 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd185260, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd186e60: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[5]: fd185314 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:5,tl=fd1832b4 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd183200, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd1850e0: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[6]: fd1832b4 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:5,tl=fd185314 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd185260, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd186e60: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[6]: fd185314 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:6,tl=fd1832b4 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd183200, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd1850e0: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd1832b4 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:6,tl=fd185314 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd185260, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd186e60: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd185314 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:7,tl=fd1832b4 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd183200, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd1850e0: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd1832b4 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:7,tl=fd185314 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd185260, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd186e60: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd185314 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:7,tl=fd1832b4 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd183200, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd1850e0: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd1832b4 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:7,tl=fd185314 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd185260, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd186e60: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd185314 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:7,tl=fd1832b4 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd183200, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd1850e0: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd1832b4 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:7,tl=fd185314 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd185260, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd186e60: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd185314 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:7,tl=fd1832b4 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd183200, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd1850e0: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd1832b4 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:7,tl=fd185314 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd185260, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd186e60: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd185314 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:7,tl=fd1832b4 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd183200, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd1850e0: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd1832b4 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:7,tl=fd185314 next=0 > 1(29442) DEBUG: retransmission_handler : reply resending (t=fd185260, SIP/2.0 5 ... ) > 1(29442) DEBUG: reply retransmitted. buf=fcf957a8: SIP/2.0 5..., shmem=fd186e60: SIP/2.0 5 > 1(29442) DEBUG: add_to_tail_of_timer[7]: fd185314 > 1(29442) DEBUG: retransmission_handler : done > 1(29442) DEBUG: timer routine:0,tl=fd1832c8 next=0 > 1(29442) DEBUG: add_to_tail_of_timer[2]: fd183248 > 1(29442) DEBUG: timer routine:7,tl=fd1832b4 next=0 > 1(29442) DEBUG: timer routine:0,tl=fd185328 next=0 > 1(29442) DEBUG: add_to_tail_of_timer[2]: fd1852a8 > 1(29442) DEBUG: timer routine:7,tl=fd185314 next=0 > 1(29442) DEBUG: timer routine:2,tl=fd183248 next=0 > 1(29442) DEBUG: wait_handler : removing fd183200 from table > 1(29442) DEBUG: delete transaction fd183200 > 1(29442) DEBUG: wait_handler : done > 1(29442) DEBUG: timer routine:2,tl=fd1852a8 next=0 > 1(29442) DEBUG: wait_handler : removing fd185260 from table > 1(29442) DEBUG: delete transaction fd185260 > 1(29442) DEBUG: wait_handler : done > ^C 0(29441) INT received, program terminates > 1( 1( 1(29442) INFO: signal 15 received > 1(29442) Memory status (pkg): > 1(29442) fm_status (99f88): > 1(29442) heap size= 1047440 > 1(29442) dumping free list: > 1(29442) hash = 1 fragments no.: 3, > bucket size: 8 - 8 (first 8) > 1(29442) hash = 2 fragments no.: 1, > bucket size: 16 - 16 (first 16) > 1(29442) hash = 4 fragments no.: 1, > bucket size: 32 - 32 (first 32) > 1(29442) hash = 46 fragments no.: 1, > bucket size: 368 - 368 (first 368) > 1(29442) hash = 265 fragments no.: 1, > bucket size: 524288 - 1048576 (first 1042560) > 1(29442) TOTAL: 7 free fragments = 1043000 free bytes > 1(29442) ----------------------------- > 0(29441) DEBUG: tm_shutdown : start > 0(29441) DEBUG: tm_shutdown : empting DELETE list > 0(29441) DEBUG: tm_shutdown : empting hash table > 0(29441) DEBUG: tm_shutdown: releasing timers > 0(29441) DEBUG: tm_shutdown : removing semaphores > 0(29441) DEBUG: tm_shutdown : done > 0(29441) Memory status (pkg): > 0(29441) fm_status (99f88): > 0(29441) heap size= 1047440 > 0(29441) dumping free list: > 0(29441) hash = 1 fragments no.: 7, > bucket size: 8 - 8 (first 8) > 0(29441) hash = 2 fragments no.: 31, > bucket size: 16 - 16 (first 16) > 0(29441) hash = 3 fragments no.: 7, > bucket size: 24 - 24 (first 24) > 0(29441) hash = 4 fragments no.: 38, > bucket size: 32 - 32 (first 32) > 0(29441) hash = 5 fragments no.: 2, > bucket size: 40 - 40 (first 40) > 0(29441) hash = 7 fragments no.: 1, > bucket size: 56 - 56 (first 56) > 0(29441) hash = 8 fragments no.: 1, > bucket size: 64 - 64 (first 64) > 0(29441) hash = 9 fragments no.: 1, > bucket size: 72 - 72 (first 72) > 0(29441) hash = 15 fragments no.: 2, > bucket size: 120 - 120 (first 120) > 0(29441) hash = 17 fragments no.: 1, > bucket size: 136 - 136 (first 136) > 0(29441) hash = 42 fragments no.: 1, > bucket size: 336 - 336 (first 336) > 0(29441) hash = 68 fragments no.: 1, > bucket size: 544 - 544 (first 544) > 0(29441) hash = 71 fragments no.: 1, > bucket size: 568 - 568 (first 2( 2( 2(29443) INFO: signal 15 received > 2(29443) Memory status (pkg): > 2(29443) fm_status (99f88): > 2(29443) heap size= 1047440 > 2(29443) dumping free list: > 2(29443) hash = 1 fragments no.: 3, > bucket size: 8 - 8 (first 8) > 2(29443) hash = 2 fragments no.: 1, > bucket size: 16 - 16 (first 16) > 2(29443) hash = 4 fragments no.: 1, > bucket size: 32 - 32 (first 32) > 2(29443) hash = 46 fragments no.: 1, > bucket size: 368 - 368 (first 368) > 2(29443) hash = 265 fragments no.: 1, > bucket size: 524288 - 1048576 (first 1042560) > 2(29443) TOTAL: 7 free fragments = 1043000 free bytes > 2(29443) ----------------------------- > 568) > 0(29441) hash = 93 fragments no.: 1, > bucket size: 744 - 744 (first 744) > 0(29441) hash = 122 fragments no.: 1, > bucket size: 976 - 976 (first 976) > 0(29441) hash = 128 fragments no.: 1, > bucket size: 1024 - 1024 (first 1024) > 0(29441) hash = 265 fragments no.: 1, > bucket size: 524288 - 1048576 (first 1036808) > 0(29441) TOTAL: 98 free fragments = 1043584 free bytes > 0(29441) ----------------------------- > 0(29441) Memory status (shm): > 0(29441) fm_status (fd000000): > 0(29441) heap size= 33553296 > 0(29441) dumping free list: > 0(29441) hash = 1 fragments no.: 4, > bucket size: 8 - 8 (first 8) > 0(29441) hash = 2 fragments no.: 1, > bucket size: 16 - 16 (first 16) > 0(29441) hash = 5 fragments no.: 3, > bucket size: 40 - 40 (first 40) > 0(29441) hash = 6 fragments no.: 3, > bucket size: 48 - 48 (first 48) > 0(29441) hash = 41 fragments no.: 2, > bucket size: 328 - 328 (first 328) > 0(29441) hash = 48 fragments no.: 1, > bucket size: 384 - 384 (first 384) > 0(29441) hash = 91 fragments no.: 1, > bucket size: 728 - 728 (first 728) > 0(29441) hash = 122 fragments no.: 2, > bucket size: 976 - 976 (first 976) > 0(29441) hash = 130 fragments no.: 1, > bucket size: 1040 - 1040 (first 1040) > 0(29441) hash = 210 fragments no.: 1, > bucket size: 1680 - 1680 (first 1680) > 0(29441) hash = 257 fragments no.: 4, > bucket size: 2048 - 4096 (first 3080) > 0(29441) hash = 258 fragments no.: 2, > bucket size: 4096 - 8192 (first 4096) > 0(29441) hash = 266 fragments no.: 1, > bucket size: 1048576 - 2097152 (first 1572864) > 0(29441) hash = 270 fragments no.: 1, > bucket size: 16777216 - 33554432 (first 31952928) > 0(29441) TOTAL: 27 free fragments = 33553072 free bytes > 0(29441) ----------------------------- > 0(29441) shm_mem_destroy > 0(29441) destroying the shared memory lock > 0(29441) Thank you for flying ser > # > script done on Tue 30 Mar 2004 05:11:06 PM CST > _______________________________________________ > Serusers mailing list > serusers(a)lists.iptel.org > http://lists.iptel.org/mailman/listinfo/serusers

20 years, 10 months

FW: [Serusers] Sems Error

by Shirley

Hi, My ls -la /tmp/*fifo is as below: Thanks [root@sipserver2 root]# ls -la /tmp/*fifo prw-r--r-- 1 root root 0 Mar 18 16:57 /tmp/am_fifo prw-rw---- 1 root root 0 Apr 7 19:45 /tmp/ser_fifo prw-r--r-- 1 root root 0 Apr 7 17:15 /tmp/ser_vm_fifo prw-rw---- 1 root root 0 Mar 24 18:48 /tmp/vm_ser_fifo Regards, Shirley > -----Original Message----- > From: Shirley > Sent: Sunday, March 07, 2004 8:33 PM > To: 'Ulrich Abend' > Subject: RE: [Serusers] Sems Error > > Hi, > > Thank you for your reply. How to make sure that the SEMS is running? > I uses the /usr/local/sin/sems.redhat start- to start the sems service? Am > I correct? > My fifo name is same in both file that you mention. Please advice! Thanks > > Regards, > Shirley > > -----Original Message----- > From: Ulrich Abend [SMTP:ullstar@iptel.org] > Sent: Wednesday, April 07, 2004 8:00 PM > To: serusers(a)lists.iptel.org > Cc: Shirley > Subject: Re: [Serusers] Sems Error > > Hi, > > you should make shure, SEMS is running and uses the same fifo name (in > sems.conf) as SER (in ser.cfg). > > It is also important, that the fifo file (default: /tmp/am_fifo) has write > > permissions for the user SER runs as. The easiest setup is to run SER and > SEMS as the same user. > > If you still experience problems, please post SER and SEMS debugging > output, > the config files, and the results of > ls -la /tmp/*fifo > > Regards, > > Uli. > > > On Wednesday 07 April 2004 12:28, Shirley wrote: > > Hi all, > > > > Please Help!!! I am trying to install the sems when I try to start the > sems > > I encountered this problem as per below. I am running on Linux 9.0 and > > please also advice on how to check the fifo version....Thanks > > > > Mar 24 19:04:25 sipserver2 /usr/local/sbin/ser[12876]: ERROR: voicemail: > > ans_machine deamon is not running ! > > Mar 24 19:04:25 sipserver2 /usr/local/sbin/ser[12876]: ERROR: voicemail: > No > > such device or address > > Mar 24 19:04:25 sipserver2 /usr/local/sbin/ser[12876]: ERROR: vm_start: > > write_to_fifo failed > > Mar 24 19:04:35 sipserver2 /usr/local/sbin/ser[12874]: ERROR: voicemail: > > ans_machine deamon is not running ! > > Mar 24 19:04:35 sipserver2 /usr/local/sbin/ser[12874]: ERROR: voicemail: > No > > such device or address > > Mar 24 19:04:35 sipserver2 /usr/local/sbin/ser[12874]: ERROR: vm_start: > > write_to_fifo failed > > > > regards, > > shirley > > > > _______________________________________________ > > Serusers mailing list > > serusers(a)lists.iptel.org > > http://lists.iptel.org/mailman/listinfo/serusers

20 years, 10 months

← Newer
1
...
17
18
19
20
21
22
23
...
27
Older →

Jump to page:

2025

2024

2023

2022

2021

2020

2019

2018

2017

2016

2015

2014

2013

2012

2011

2010

2009

2008

2007

2006

2005

2004

2003

2002

sr-users April 2004