Resources.DocsTsStart History

Hide minor edits - Show changes to markup

April 24, 2013, at 06:37 PM by 213.233.101.41 -
Changed lines 1-787 from:

Resources -> Documentation -> Doesn't start

Where to check OpenSIPS does not start?

What is the problem?

More likely you have a configuration error (script error) or a permission error that prevents your OpenSIPS to start.
First of all you have to identify the cause of the error, so look for the OpenSIPS output.

Where to look for logs

If you have log_stderror=no in your config file (opensips.cfg), all the logs from OpenSIPS will be sent to the syslog service, so you have the check into the corresponding file, typically:

  1. /var/log/syslog
  2. /var/log/messages

You can simply check system log by:
$ tail -f /var/log/messages

Note you might need root permissions to access these files! If you do not have it, set log_stderror=yes in your config and you will get the log in the console.

If you have log_stderror=yes, you should get the log in the console where you are run OpenSIPS

Reading the error logs

The logs should give you some idea about what went wrong and prevented your OpenSIPS to start. The info from the logs is quite comprehensive to point you the problem. Even so, it some cases you may consider increasing the verbosity of the logs by setting a higher debug level (debug=4) - it is recommended to do it if you do not see any ERROR message in the first case.

If no still no clue, use the mailing lists to get help on this - do not forget to post the OpenSIPS logs in your email.

(:nl:)>>messagehead<<

nengneng?22 April 2009, 07:18

hello, When I

 opensipsctl start

INFO: Starting OpenSIPS :

ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

I looked for the OpenSIPS output: Apr 22 12:10:06 zhuruimin-desktop opensips: INFO:core:init_tcp: using epoll_lt as the TCP io watch method (auto detected) Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: NOTICE:core:main: version: opensips 1.5.0-notls (i386/linux) Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:core:main: using 64 Mb shared memory Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:core:main: using 1 Mb private memory per process Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:sl:mod_init: Initializing StateLess engine Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:tm:mod_init: TM - initializing... Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:maxfwd:mod_init: initializing... Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:usrloc:ul_init_locks: locks array size 512 Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:registrar:mod_init: initializing... Apr 22 12:29:00 zhuruimin-desktop -- MARK -- Apr 22 12:49:00 zhuruimin-desktop -- MARK --

i don't know how to fix it,Can anybody give me some suggestions..

Thanks,

[bogdan] setting debug level to 4 may give you more hints on what the issue is.

(:nl:)>>messagehead<<

nengneng?28 April 2009, 08:22

Hello bogdan,I am terribly sorry for sawing your response so late. I truly appreciate your prompt response. I did according to your propsal, and it returned the following output,(I only posted the latter part):

Apr 28 13:42:36 [7334] DBG:db_mysql:db_mysql_new_connection: opening connection: mysql://xxxx:xxxx@localhost/opensips Apr 28 13:42:36 [7334] ERROR:db_mysql:db_mysql_new_connection: driver error(1045): Access denied for user 'opensips'@'localhost' (using password: YES) Apr 28 13:42:36 [7334] ERROR:core:db_do_init: could not add connection to the pool Apr 28 13:42:36 [7334] ERROR:auth_db:auth_fixup: unable to open database connection Apr 28 13:42:36 [7334] ERROR:core:fix_actions: fixing failed (code=-1) at cfg line 328 Apr 28 13:42:36 [7334] CRITICAL:core:fix_expr: fix_actions error Apr 28 13:42:36 [7334] ERROR:core:main: failed to fix configuration with err code -1 Apr 28 13:42:36 [7334] DBG:xlog:destroy: destroy module... Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: tm_shutdown : start Apr 28 13:42:36 [7334] DBG:tm:unlink_timer_lists: emptying DELETE list Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: emptying hash table Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: releasing timers Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: removing semaphores Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: destroying callback lists Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: tm_shutdown : done Apr 28 13:42:36 [7334] DBG:core:shm_mem_destroy: Apr 28 13:42:36 [7334] DBG:core:shm_mem_destroy: destroying the shared memory lock

Thanks in Advance

(:nl:)>>messagehead<<

nengneng?28 April 2009, 09:24

Hello bogdan, I am fixed the matter up now. I checked the opensips.cfg, "modparam("[modulename]", "db_url", "mysql://opensips:opensipsrw@localhost:mysql/opensips"), but in MySQL, the user "opensips" has a password "opensips",I changed the password, and now Opensips is running.

Thank you!

(:nl:)>>messagehead<<

nengneng?29 April 2009, 16:45

Hello,there was something wrong when I configurate opensips-cp2.0. In the Makefile,I removed the "mi_xmlrpc" module, then "make all","make install", and maked the following changes in the opensips file configuration /usr/local/etc/opensips/opensips.cfg/: loadmodule "mi_fifo.so" modparam("mi_fifo", "fifo_name", "/tmp/opensips_fifo") modparam("mi_fifo", "fifo_mode", 0600) modparam("mi_fifo", "fifo_group", 0) modparam("mi_fifo", "fifo_group", "root") modparam("mi_fifo", "fifo_user", 0) modparam("mi_fifo", "fifo_user", "root") modparam("mi_fifo", "reply_dir", "/home/opensips/tmp/") modparam("mi_fifo", "reply_indent", " ")

when I ,"/etc/init.d/opensips start",it returned the following output,(I only posted the latter part): Apr 29 22:42:39 [1478] INFO:textops:mod_init: initializing... Apr 29 22:42:39 [1478] DBG:core:init_mod: initializing module mi_fifo Apr 29 22:42:39 [1478] DBG:mi_fifo:mi_mod_init: testing fifo existance ... Apr 29 22:42:39 [1478] ERROR:mi_fifo:mi_mod_init: directory stat failed: No such file or directory Apr 29 22:42:39 [1478] ERROR:core:init_mod: failed to initialize module mi_fifo Apr 29 22:42:39 [1478] ERROR:core:main: error while initializing modules ………………………… Can anybody give me some suggestions.Thank you!

(:nl:)>>messagehead<<

Lawrence?26 July 2009, 21:26

Took me abit of time... have got 99.9 percent complete... i can "service opensips start" the service will start. When 'chkconfig --add opensips' is enter'd i get 'service opensips does not support chkconfig' any ideas... built on centos 5.3

[bogdan] - to be able to use the chkconfig, you need to place in the /etc/init.d/opensips file, in the begining, a line line "# chkconfig: 2345 20 80" to indicate the start / stop level - please see the man page for chkconfig.

(:nl:)>>messagehead<<

ItMightHep?10 December 2009, 09:25
 opensipsctl start

INFO: Starting OpenSIPS :

ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

This issue is solved by login with user id which is used to install this in my case it is root. i don't have much idea on this but it might help someone.

(:nl:)>>messagehead<<

Webgeek?23 December 2009, 00:28

I'm getting this error:

opensips:~# opensips restart Dec 22 23:27:36 [2287] WARNING:core:fix_socket_list: could not rev. resolve 192.168.1.60 Dec 22 23:27:36 [2287] WARNING:core:fix_socket_list: could not rev. resolve 192.168.1.60 Listening on

             udp: 127.0.0.1 [127.0.0.1]:5060
             udp: 192.168.1.60 [192.168.1.60]:5060
             tcp: 127.0.0.1 [127.0.0.1]:5060
             tcp: 192.168.1.60 [192.168.1.60]:5060

Aliases:

             tcp: localhost:5060
             udp: localhost:5060

Dec 22 23:27:36 [2287] INFO:core:init_tcp: using epoll_lt as the TCP io watch method (auto detected) Dec 22 23:27:36 [2289] NOTICE:core:main: version: opensips 1.6.0-notls (i386/linux) Dec 22 23:27:36 [2289] INFO:core:main: using 32 Mb shared memory opensips:~# Dec 22 23:27:36 [2289] INFO:core:main: using 1 Mb private memory per process Dec 22 23:27:36 [2289] NOTICE:signaling:mod_init: initializing module ... Dec 22 23:27:36 [2289] INFO:sl:mod_init: Initializing StateLess engine Dec 22 23:27:36 [2289] INFO:tm:mod_init: TM - initializing... Dec 22 23:27:36 [2289] INFO:maxfwd:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:usrloc:ul_init_locks: locks array size 512 Dec 22 23:27:36 [2289] INFO:registrar:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:textops:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:xlog:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:acc:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:auth:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:auth_db:mod_init: initializing... Dec 22 23:27:36 [2289] ERROR:uri:obsolete_fixup_0: You are using one of these obsolete functions: "check_to", "check_from", "does_uri_exist","get_auth_id". They have been renamed with the "db_" prefix. Dec 22 23:27:36 [2289] ERROR:core:fix_actions: fixing failed (code=-6) at cfg line 257 Dec 22 23:27:36 [2289] CRITICAL:core:fix_expr: fix_actions error Dec 22 23:27:36 [2289] ERROR:core:main: failed to fix configuration with err code -6

The main problem seems to be this: Dec 22 23:27:36 [2289] ERROR:uri:obsolete_fixup_0: You are using one of these obsolete functions: "check_to", "check_from", "does_uri_exist","get_auth_id". They have been renamed with the "db_" prefix. Dec 22 23:27:36 [2289] ERROR:core:fix_actions: fixing failed (code=-6) at cfg line 257

I've spent some time lloking for the functions, but can't seem to find it. Thanks Sam

[bogdan] - see migration docs http://www.opensips.org/Resources/DocsMigration15to16 ; check_to() -> db_check_to()

(:nl:)>>messagehead<<

Lawrence?07 January 2010, 01:14

I keep getting this eror when trying to start open sips, here is all of the log tail, i cant for the life of me find where to chage the parameter.... andy ideas anyone where to begin the search? opensips: ERROR:core:get_script_route_idx: Script route <1> is redefined

[bogdan] - your script defines twice the route id 1 - look for "route[1]" - it must be only once

(:nl:)>>messagehead<<

cicciosbo?19 February 2010, 15:24

ERROR: Error opening OpenSIPS's FIFO /tmp/opensips_fifo ERROR: Make sure you have the line 'modparam("mi_fifo", "fifo_name", "/tmp/opensips_fifo")' in your config ERROR: and also have loaded the mi_fifo module.

(:nl:)>>messagehead<<

please?03 March 2010, 19:36

HI I got some problem integration with asterisk

I got error when step #opensipsctl fifo domain reload This error is "500 command 'domain' not available".

SO I stop the opensipsctl and start again follow

[root@TEST opensips]# opensipsctl start

INFO: Starting OpenSIPS :

ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

So I check in /var/log/messages and got follow

Mar 4 00:25:05 TEST opensips: ERROR:core:yyparse: module 'uri_db.so' not found in '/lib/opensips/modules/' Mar 4 00:25:05 TEST opensips: CRITICAL:core:yyerror: parse error in config file, line 37, column 13-14: failed to load module Mar 4 00:25:05 TEST opensips: ERROR:core:sr_load_module: could not open module </lib/opensips/modules/>: /lib/opensips/modules/: cannot read file data: Is a directory Mar 4 00:25:05 TEST opensips: CRITICAL:core:yyerror: parse error in config file, line 37, column 13-14: failed to load module Mar 4 00:25:05 TEST opensips: ERROR:core:set_mod_param_regex: no module matching uri_db found Mar 4 00:25:05 TEST opensips: CRITICAL:core:yyerror: parse error in config file, line 63, column 19-20: Parameter <use_uri_table> not found in module <uri_db> - can't set Mar 4 00:25:05 TEST opensips: ERROR:core:set_mod_param_regex: no module matching uri_db found Mar 4 00:25:05 TEST opensips: CRITICAL:core:yyerror: parse error in config file, line 64, column 20-21: Parameter <db_url> not found in module <uri_db> - can't set Mar 4 00:25:05 TEST opensips: ERROR:core:main: bad config file (4 errors)

Can You guys instruction to me?

Thanks Please

(:nl:)>>messagehead<<

Vishu?22 March 2010, 10:58

Hi

i am getting following error while starting opensips:

debian:/etc/opensips# /etc/init.d/opensips restart chown: invalid user: `opensips:opensips'

Can someone suggest..

[bogdan] - probably you did not create the "opensips" user and "opensips" group on your system.

(:nl:)>>messagehead<<

john pope08 April 2010, 11:55

set use the username password as opensips /opensipsrw in mysql gui browser

(:nl:)>>messagehead<<

Robin?25 July 2010, 20:17

Hello, I really need some help with getting opensips to start. I checked the user in MySql and in the opensips.cfg file, yet I'm getting the error in the log below. Jul 25 14:12:01 [20481] DBG:textops:fixup_method: using id for method [REGISTER/128] Jul 25 14:12:01 [20481] DBG:core:fix_actions: fixing save, line 329 Jul 25 14:12:01 [20481] DBG:core:db_do_init: connection 0x81a386c not found in pool Jul 25 14:12:01 [20481] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/1sip2open Jul 25 14:12:01 [20481] ERROR:db_mysql:db_mysql_connect: driver error(1045): Access denied for user 'opensips'@'localhost' (using password: YES) Jul 25 14:12:01 [20481] ERROR:db_mysql:db_mysql_new_connection: initial connect failed Jul 25 14:12:01 [20481] ERROR:core:db_do_init: could not add connection to the pool Jul 25 14:12:01 [20481] ERROR:usrloc:register_udomain: failed to open database connection Jul 25 14:12:01 [20481] ERROR:registrar:domain_fixup: failed to register domain Jul 25 14:12:01 [20481] ERROR:core:fix_actions: fixing failed (code=-1) at cfg line 329 Jul 25 14:12:01 [20481] CRITICAL:core:fix_expr: fix_actions error Jul 25 14:12:01 [20481] ERROR:core:main: failed to fix configuration with err code -1 Jul 25 14:12:01 [20481] DBG:xlog:destroy: destroy module... Jul 25 14:12:01 [20481] DBG:tm:tm_shutdown: tm_shutdown : start

Thanks

[bogdan] - in opensips cfg, the db_url for usrloc module is not correctly set.

(:nl:)>>messagehead<<

Chrispy?01 September 2010, 01:46

Here's a weird one. I have OpenSIPS up and running fine for over a month. It responds and mi is talking via xmlrpc to OpenSIPS-CP just fine. I start it up using chkconfig with the startup script I found on opensips.org for CentOS (/etc/init.d/opensips).

The weird thing is that despite starting fine, opensips doesn't create a pid file in /var/run (or anywhere else.) I just noticed this because I'm trying to setup Monit on the opensips box, and it wants to see the pid file.

Can't be rights, I opened up /var and /var/run with chmod 777 just to ensure.

CentOS 5.5, uname -a reports: 2.6.18-194.8.1.el5PAE OpenSIPS 1.6.2

[bogdan] - do you start opensips with -p param to point to a PD file ?

(:nl:)>>messagehead<<

jm21?20 September 2010, 22:22

Hi, I've setup Opensips with mysql support but am having issues getting it to start. i get the following error:

ERROR: No PID file found (/var/run/opensips.pid)! OpenSIPS probably not running INFO: check with 'ps -ef | /bin/egrep opensips'

when i do a tail /var/log/messages i get the following:

Sep 20 15:52:22 CL-T020-483CL opensips: INFO:acc:mod_init: initializing... Sep 20 15:52:22 CL-T020-483CL opensips: INFO:auth:mod_init: initializing... Sep 20 15:52:22 CL-T020-483CL opensips: INFO:auth_db:mod_init: initializing... Sep 20 15:52:22 CL-T020-483CL opensips: INFO:core:probe_max_receive_buffer: using a UDP receive buffer of 255 kb Sep 20 16:13:14 CL-T020-483CL opensips: INFO:core:sig_usr: signal 2 received Sep 20 16:13:14 CL-T020-483CL last message repeated 2 times Sep 20 16:13:14 CL-T020-483CL opensips: INFO:core:handle_sigs: child process 585 6 exited normally, status=0 Sep 20 16:13:14 CL-T020-483CL opensips: INFO:core:handle_sigs: child process 585 7 exited normally, status=0 Sep 20 16:13:14 CL-T020-483CL opensips: INFO:core:handle_sigs: terminating due t o SIGCHLD Sep 20 16:13:14 CL-T020-483CL opensips: INFO:core:sig_usr: signal 15 received

Does anyone have an idea of whats wrong or what i could be doing wrong?

[bogdan] - signal 2 is SIGINT - looks like your opensips is terminated by other app.

(:nl:)>>messagehead<<

sipsip?13 January 2011, 11:13

Dear Bogdan ,

When i run OpensISPS, iam getting the following error

 /etc/init.d/opensips start
 *chown: `opensips:opensips': invalid user
  • Please help How to create the "opensips" user and "opensips" group on your system ??

[bogdan] - use "adduser" and "addgroup" system commands

(:nl:)>>messagehead<<

sipsip?13 January 2011, 11:24

this is my /etc/default/opesips

  1. OpenSIPS startup options
  2. Set to yes to enable opensips, once configured properly.

RUN_OPENSIPS=yes

  1. User to run as

USER=opensips

  1. Group to run as

GROUP=opensips

  1. Amount of memory to allocate for the running OpenSIPS server (in Mb)

MEMORY=128

  1. Enable the server to leave a core file when it crashes.
  2. Set this to 'yes' to enable OpenSIPS to leave a core file when it crashes
  3. or 'no' to disable this feature. This option is case sensitive and only
  4. accepts 'yes' and 'no' and only in lowercase letters.
  5. On some systems (e.g. Ubuntu 6.10, Debian 4.0) it is necessary to specify
  6. a directory for the core files to get a dump. Look into the opensips
  7. init file for an example configuration.

DUMP_CORE=no

so, where is the problem??

(:nl:)>>messagehead<<

Mahmut Cahmut?28 January 2011, 10:55

dhcppc:~# opensipsctl start

INFO: Starting OpenSIPS :

ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed any solution for this issue ?

[bogdan] - check the log files (see the page content) for opensips errors - most probably your opensips fails to start.

(:nl:)>>messagehead<<

Naser ?22 February 2011, 19:41

I have similar problem, when i start opensips it works and give the message of listening, but when i check the status of opensips it say, opensips not running, anyone has idea about the problem,

(:nl:)>>messagehead<<

Bhavik Pandya?11 April 2011, 22:12

bhavik@prithvi:~$ opensipsctl restart

[: 2443: restart: unexpected operator -e E[37;33mINFO: Stopping OpenSIPS :

-e E[37;31mERROR: No PID file found (/var/run/opensips.pid)! OpenSIPS probably not running

-e E[37;33mINFO: Starting OpenSIPS :

-e E[37;31mERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

-- I have checked my user name and password, its the same in opensips.cfg file and mysql. -- The /var/run directory has full permissions -- I also have done sudo opensipsctl restart, thus trying to login as a root -- I tried to create a new account in mysql, but still couldnot solve this problem...

Any help will be appreciated...

[bogdan] - check the log files (see the page content) for opensips errors - most probably your opensips fails to start.

(:nl:)>>messagehead<<

lisongchao?21 May 2011, 10:30

ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

and when I check /var/log/messages that show

May 21 16:26:47 linux5-uc last message repeated 2 times May 21 16:26:47 linux5-uc ./opensips[8549]: ERROR:core:tcp_init: bind(8, 0x81be074, 16) on 127.0.0.1:5060 : Address already in use

help help and what's the problem???

[bogdan] - either another opensips instance, either another application is listening on the same tcp:IP:PORT as you configured your opensips - check with "netstat -tlnp"

(:nl:)>>messagehead<<

sipsip?07 July 2011, 12:28

Dear Bogdan I tried to set up opensips 1.6.2 but i alwyes get this error

root@debtest:~# opensipsctl start -e E[37;32mWARNING: database engine not found - tried 'MYSQL' -e Control engine 'FIFO' loaded

-e E[37;33mINFO: Starting OpenSIPS : -e E[37;33mINFO: started (pid: 1693) i spent much time searching this error but find nothing , can u help me how to solve this problem ?

(:nl:)>>messagehead<<

prabb?02 August 2011, 23:53

Probably what you should have said at the head of the document, is: "create a system user with linux adduser command and nologin. Example: adduser opensips nologin.

(:nl:)>>messagehead<<

prabb?03 August 2011, 20:21

If someone could write a manual for a CentOS install, it might look like CENTOS 5 INSTALL 1. Prequisites include all dependency installs of centOS5, linux LAMP and asterisk; don't install asterisk.

2. A system user will need to be added to install opensips with nologin. adduser opensips nologin.

3. Download all opensips packages from opensips. rpms for CentOS are found at SourceForge. As of mid 2011: opensips-1.7.0-0.i386.rpm opensips-b2bua-1.7.0-0.i386.rpm opensips-cpl-1.7.0-0.i386.rpm opensips-debuginfo-1.7.0-0.i386.rpm opensips-jabber-1.4.5-0.i386.rpm opensips-mysql-1.7.0-0.i386.rpm

4. Download perl-Frontier-RPC. This was found at pbone.net linked to daag. perl-Frontier-RPC-0.07b4-1.el5.rf.noarch.rpm. rpm -i perl-Frontier-RPC..etc

5. rpm -i opensips-1.7 (base). Then mysql and the rest.

6. At /etc/default/opensips, ensure the following is uncommented:

  1. Set to yes to enable opensips, once configured properly.

RUN_OPENSIPS=yes

  1. User to run as

USER=opensips

  1. Group to run as

GROUP=opensips

7. Now opensips should be able to be daemonized. chkconfig opensips on service opensips start (stop / restart / status)

8. At /etc/opensips/opensips.cfg, uncomment as follows: /* uncomment the next line to disable TCP (default on) */ disable_tcp=yes

  1. default db_url to be used by modules requiring DB connection

db_default_url="mysql://opensips:opensipsrw@localhost/opensips"

/* uncomment next line for MySQL DB support */

9. At /etc/opensips/opensipsctlrc, uncomment as follows:

  1. If you want to setup a database with opensipsdbctl, you must at least specify
  2. this parameter.

DBENGINE=MYSQL

  1. database host

DBHOST=localhost

  1. database name (for ORACLE this is TNS name)

DBNAME=opensips

  1. database path used by dbtext or db_berkeley
  2. DB_PATH="/usr/local/etc/opensips/dbtext"
    1. database read/write user

DBRWUSER=opensips

  1. password for database read/write user

DBRWPW="password"

  1. database super user (for ORACLE this is 'scheme-creator' user)

DBROOTUSER="root"

  1. user name column

USERCOL="username"

10. Now at /etc/opensips/ you should be able to run the following command to create a database from script: opensipsdbctl create the process is interactive.

11. service restart opensips. [OK] doesn't usually appear, status shows it running.

you're welcome.

(:nl:)>>messagehead<<

manish11 August 2011, 20:30

Dear Bogdan i am getting following error after i start opensips ERROR: No PID file found (/var/run/opensips/opensips.pid)! OpenSIPS probably not running

can i create pid file in the /var/run/opensips how to check that opensips is running

if i run sudo /etc/init.d/opensips start it gives me Starting opensips: opensipsListening on

             udp: 127.0.0.1 [127.0.0.1]:5060
             udp: 10.0.0.5 [10.0.0.5]:5060
             tcp: 127.0.0.1 [127.0.0.1]:5060
             tcp: 10.0.0.5 [10.0.0.5]:5060

Aliases:

             tcp: ADHIRAAJ.local:5060
             tcp: localhost:5060
             udp: ADHIRAAJ.local:5060
             udp: localhost:5060

but with ps ax command it doesnt show me that opensip is running

pl help

(:nl:)>>messagehead<<

manish11 August 2011, 20:37

also my log messages gives the following Aug 12 00:04:44 ADHIRAAJ opensips: INFO:core:init_tcp: using epoll_lt as the TCP io watch method (auto detected) Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: NOTICE:core:main: version: opensips 1.5.0-tls (i386/linux) Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:core:main: using 64 Mb shared memory Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:core:main: using 1 Mb private memory per process Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: NOTICE:signaling:mod_init: initializing module ... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:sl:mod_init: Initializing StateLess engine Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:tm:mod_init: TM - initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:maxfwd:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:usrloc:ul_init_locks: locks array size 512 Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:registrar:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:textops:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:xlog:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:acc:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:auth:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:auth_db:mod_init: initializing... Aug 12 00:04:45 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:core:probe_max_receive_buffer: using a UDP receive buffer of 255 kb Aug 12 00:05:06 ADHIRAAJ opensips: INFO:core:init_tcp: using epoll_lt as the TCP io watch method (auto detected) Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: NOTICE:core:main: version: opensips 1.5.0-tls (i386/linux) Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:core:main: using 32 Mb shared memory Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:core:main: using 1 Mb private memory per process Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: NOTICE:signaling:mod_init: initializing module ... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:sl:mod_init: Initializing StateLess engine Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:tm:mod_init: TM - initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:maxfwd:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:usrloc:ul_init_locks: locks array size 512 Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:registrar:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:textops:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:xlog:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:acc:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:auth:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:auth_db:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:core:probe_max_receive_buffer: using a UDP receive buffer of 255 kb

(:nl:)>>messagehead<<

Rico?20 October 2011, 14:57
 ERROR:core:db_check_table_version: invalid version 0 for table subscriber found, expected 7
 ERROR:uri:mod_init: Invalid table version.
 ERROR:core:init_mod: failed to initialize module uri
 ERROR:core:main: error while initializing modules

Opensips doen't start becose of this (module uri)..

Please help.

(:nl:)>>messagehead<<

Scott?29 December 2011, 00:06

Starting OpenSER : ERROR: PID file /var/run/openser.pid does not exist -- OpenSER start failed

ec 28 17:01:44 localhost /usr/local/sbin/openser[8184]: INFO: statistics manager successfully initialized Dec 28 17:01:44 localhost /usr/local/sbin/openser[8184]: INFO:ul_init_locks: locks array size 512 Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: TextOPS - initializing Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: TM - initializing... Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: StateLess module - initializing Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: Maxfwd module- initializing Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: AUTH module - initializing Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: AUTH_DB module - initializing Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: XLOG:xdbg_fixup: ERROR: wrong format[Local user offline - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci ]! Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: ERROR: fix_actions: fixing failed (code=-1) at cfg line 447 Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: INFO:mi_fifo:mi_destroy: process hasn't been created -> nothing to kill

thanks

[bogdan] It seams you have an old version (if xlog still a module) - print here the script line with the xlog

(:nl:)>>messagehead<<

Tasos?15 February 2012, 16:06

Hello,

I have just installed the opensips and opensips-cp. I have registered a user successfully. If i run opensipsctl monitor i can see 1 user online. The problem is that this user is seen as offline in the opensips-cp. Any ideas?

Thanks in advance

(:nl:)>>messagehead<<

Tasos?15 February 2012, 16:15

Update: The user was created via console before i install cp. It seems that i cannot create a user via cp. The domain drop-down menu is empty... It seems that something is wrong.Any ideas on that?

Thanks again in advance!

(:nl:)>>messagehead<<

H-Anh?31 March 2012, 18:36

Hi all,

I have installed Opensips in Cent OS 6. With default opensips.cfg. Opensips started successfully. Then I stop opensips by Command: service opensips stop Or opensipsctl stop. Opensips stop [OK]. Then I change something (ex: parameters, routing,..), then I start opensips: The result is:

PID File /var/run/opensips.pid does not exit. OpenSIPS start failed.

I've checked /etc/init.d/opensips, /etc/rc.d/init.d/functions, usr/local/etc/opensips/opensipsctlrc with the same dir for: /var/run/opensips.pid. Reboot the system, using root user. But the problem is the same.

Somebody can help me?

Thanks

(:nl:)>>messagehead<<

casey?17 April 2012, 18:35

Hi,All Apr 17 09:34:13 localhost opensips: CRITICAL:core:yyerror: 2parse error in config file, line 192, column 1-6: syntax error Apr 17 09:34:13 localhost opensips: CRITICAL:core:yyerror: 2parse error in config file, line 192, column 1-6: Invalid arguments Apr 17 09:34:13 localhost opensips: ERROR:core:main: bad config file (2 errors)

Thanks

(:nl:)>>messagehead<<

Rick?21 May 2012, 08:13

Hi All,

I also received the same error --> PID File /var/run/opensips.pid does not exit. OpenSIPS start failed. I see that many have observed the same error, but i see no solution to that in the site. Can someone who have solved this issue make a post so that others are benefited..

Thanks

(:nl:)>>messagehead<<

Kumar?30 October 2012, 15:02

Hi.. I am following the webinar "OpenSIPS Kick Start.wmv" I have exactly everything same .. but still when i use this command,

root@opensips:/# opensipsctl restart bash: opensipsctl: command not found

also PID file is not there ... anyone can help?

(:nl:)>>messagehead<<

Alvin?07 March 2013, 05:56
 ERROR:db_mysql:mysql_raise_event: event not registered -1

(:nl:)>>messagehead<<

amrindhe?20 March 2013, 23:16

Hi , I am following the webinar and was able to configure everything right upto the following error. Please guide me through for removing the same. root@ubuntu:/usr/local/opensips_proxy/sbin# ./opensipsdbctl create MySQL password for root: INFO: test server charset INFO: creating database opensips ... ERROR 1007 (HY000) at line 1: Can't create database 'opensips'; database exists /usr/local/opensips_proxy//lib64/opensips/opensipsctl/opensipsdbctl.mysql: line 165: ./mysql/standard-create.sql: No such file or directory ERROR: Creating core tables failed!

(:nl:)>>messagehead<<

sakalaboator?22 March 2013, 06:33

I also encounter the mysql error. How to check the error code:1403 and what's the meaning? Mar 22 09:44:34 freeBSD /usr/local/sbin/opensips[1403]: ERROR:db_mysql:mysql_raise_event: event not registered -1

(:commentboxchrono:)

to:

(:redirect Documentation.TroubleShooting-DoesNotStart quiet=1 :)

March 22, 2013, at 06:33 AM by 218.206.107.242 - Comment added
Added lines 778-784:

(:nl:)>>messagehead<<

sakalaboator?22 March 2013, 06:33

I also encounter the mysql error. How to check the error code:1403 and what's the meaning? Mar 22 09:44:34 freeBSD /usr/local/sbin/opensips[1403]: ERROR:db_mysql:mysql_raise_event: event not registered -1

March 20, 2013, at 11:16 PM by amrindhe - Comment added
Added lines 764-777:

(:nl:)>>messagehead<<

amrindhe?20 March 2013, 23:16

Hi , I am following the webinar and was able to configure everything right upto the following error. Please guide me through for removing the same. root@ubuntu:/usr/local/opensips_proxy/sbin# ./opensipsdbctl create MySQL password for root: INFO: test server charset INFO: creating database opensips ... ERROR 1007 (HY000) at line 1: Can't create database 'opensips'; database exists /usr/local/opensips_proxy//lib64/opensips/opensipsctl/opensipsdbctl.mysql: line 165: ./mysql/standard-create.sql: No such file or directory ERROR: Creating core tables failed!

March 07, 2013, at 05:56 AM by Alvin - Comment added
Added lines 758-763:

(:nl:)>>messagehead<<

Alvin?07 March 2013, 05:56
 ERROR:db_mysql:mysql_raise_event: event not registered -1
October 30, 2012, at 03:02 PM by Kumar - Comment added
Added lines 745-757:

(:nl:)>>messagehead<<

Kumar?30 October 2012, 15:02

Hi.. I am following the webinar "OpenSIPS Kick Start.wmv" I have exactly everything same .. but still when i use this command,

root@opensips:/# opensipsctl restart bash: opensipsctl: command not found

also PID file is not there ... anyone can help?

October 25, 2012, at 10:06 AM by bogdan -
Deleted lines 744-749:

(:nl:)>>messagehead<<

Laxmikant?24 October 2012, 11:06

Hi,i would like to thank you for this post somehow i misesd that command (systemsetup) until today while it looks very promising for ard-scripts.Thumbs up for your current posts which are all interessting would be great to see if you continue your work in this blog.Greetingsfidel

October 24, 2012, at 11:06 AM by Laxmikant - Comment added
Added lines 745-750:

(:nl:)>>messagehead<<

Laxmikant?24 October 2012, 11:06

Hi,i would like to thank you for this post somehow i misesd that command (systemsetup) until today while it looks very promising for ard-scripts.Thumbs up for your current posts which are all interessting would be great to see if you continue your work in this blog.Greetingsfidel

October 22, 2012, at 01:15 PM by bogdan -
Deleted lines 744-755:

(:nl:)>>messagehead<<

Orvito?22 October 2012, 05:44

One remembers that men's life seems to be high prceid, nevertheless people need cash for different issues and not every person gets enough money. Hence to get good and college loan should be a proper way out.

(:nl:)>>messagehead<<

Victor?22 October 2012, 05:56

roz tilefonagia sou moro me lene grgioo kai eimai 32 eton .eimai se sxesh kai m endiaferei gnorimia mono gia sex.eimai omorfos me oraio soma kai to kyriotero me poly ma para poly xarismatika prosonta.steile mou to e mail sou na sou steilo alithines photos mou.filia

October 22, 2012, at 05:56 AM by Victor - Comment added
Added lines 751-756:

(:nl:)>>messagehead<<

Victor?22 October 2012, 05:56

roz tilefonagia sou moro me lene grgioo kai eimai 32 eton .eimai se sxesh kai m endiaferei gnorimia mono gia sex.eimai omorfos me oraio soma kai to kyriotero me poly ma para poly xarismatika prosonta.steile mou to e mail sou na sou steilo alithines photos mou.filia

October 22, 2012, at 05:44 AM by Orvito - Comment added
Added lines 745-750:

(:nl:)>>messagehead<<

Orvito?22 October 2012, 05:44

One remembers that men's life seems to be high prceid, nevertheless people need cash for different issues and not every person gets enough money. Hence to get good and college loan should be a proper way out.

May 21, 2012, at 08:13 AM by Rick - Comment added
Added lines 731-742:

Thanks

(:nl:)>>messagehead<<

Rick?21 May 2012, 08:13

Hi All,

I also received the same error --> PID File /var/run/opensips.pid does not exit. OpenSIPS start failed. I see that many have observed the same error, but i see no solution to that in the site. Can someone who have solved this issue make a post so that others are benefited..

April 17, 2012, at 06:35 PM by casey - Comment added
Added lines 720-730:

Thanks

(:nl:)>>messagehead<<

casey?17 April 2012, 18:35

Hi,All Apr 17 09:34:13 localhost opensips: CRITICAL:core:yyerror: 2parse error in config file, line 192, column 1-6: syntax error Apr 17 09:34:13 localhost opensips: CRITICAL:core:yyerror: 2parse error in config file, line 192, column 1-6: Invalid arguments Apr 17 09:34:13 localhost opensips: ERROR:core:main: bad config file (2 errors)

March 31, 2012, at 06:36 PM by H-Anh - Comment added
Added lines 699-721:

(:nl:)>>messagehead<<

H-Anh?31 March 2012, 18:36

Hi all,

I have installed Opensips in Cent OS 6. With default opensips.cfg. Opensips started successfully. Then I stop opensips by Command: service opensips stop Or opensipsctl stop. Opensips stop [OK]. Then I change something (ex: parameters, routing,..), then I start opensips: The result is:

PID File /var/run/opensips.pid does not exit. OpenSIPS start failed.

I've checked /etc/init.d/opensips, /etc/rc.d/init.d/functions, usr/local/etc/opensips/opensipsctlrc with the same dir for: /var/run/opensips.pid. Reboot the system, using root user. But the problem is the same.

Somebody can help me?

Thanks

February 15, 2012, at 04:15 PM by soulatsos - Comment added
Added lines 689-698:

(:nl:)>>messagehead<<

Tasos?15 February 2012, 16:15

Update: The user was created via console before i install cp. It seems that i cannot create a user via cp. The domain drop-down menu is empty... It seems that something is wrong.Any ideas on that?

Thanks again in advance!

February 15, 2012, at 04:06 PM by Tasos - Comment added
Added lines 675-688:

(:nl:)>>messagehead<<

Tasos?15 February 2012, 16:06

Hello,

I have just installed the opensips and opensips-cp. I have registered a user successfully. If i run opensipsctl monitor i can see 1 user online. The problem is that this user is seen as offline in the opensips-cp. Any ideas?

Thanks in advance

January 12, 2012, at 05:12 PM by bogdan -
Added lines 673-674:

[bogdan] It seams you have an old version (if xlog still a module) - print here the script line with the xlog

December 29, 2011, at 12:06 AM by Scott - Comment added
Added lines 651-673:

(:nl:)>>messagehead<<

Scott?29 December 2011, 00:06

Starting OpenSER : ERROR: PID file /var/run/openser.pid does not exist -- OpenSER start failed

ec 28 17:01:44 localhost /usr/local/sbin/openser[8184]: INFO: statistics manager successfully initialized Dec 28 17:01:44 localhost /usr/local/sbin/openser[8184]: INFO:ul_init_locks: locks array size 512 Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: TextOPS - initializing Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: TM - initializing... Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: StateLess module - initializing Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: Maxfwd module- initializing Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: AUTH module - initializing Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: AUTH_DB module - initializing Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: XLOG:xdbg_fixup: ERROR: wrong format[Local user offline - M=$rm RURI=$ru F=$fu T=$tu IP=$si ID=$ci ]! Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: ERROR: fix_actions: fixing failed (code=-1) at cfg line 447 Dec 28 17:01:45 localhost /usr/local/sbin/openser[8184]: INFO:mi_fifo:mi_destroy: process hasn't been created -> nothing to kill

thanks

October 27, 2011, at 04:37 PM by bogdan -
Deleted lines 650-654:

(:nl:)>>messagehead<<

Keli?26 October 2011, 18:05

Whoa, whoa, get out the way with that good ifnromation.

October 26, 2011, at 06:05 PM by Keli - Comment added
Added lines 649-654:

(:nl:)>>messagehead<<

Keli?26 October 2011, 18:05

Whoa, whoa, get out the way with that good ifnromation.

October 21, 2011, at 10:02 AM by bogdan -
Changed lines 636-637 from:

(:nl:)>>messagehead<<

Rico?20 October 2011, 14:56
to:

(:nl:)>>messagehead<<

Rico?20 October 2011, 14:57
Deleted lines 639-855:
  1. opensipsctl start

INFO: Starting OpenSIPS : ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/db_mysql.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/signaling.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/sl.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/tm.so Oct 20 14:54:49 opensips opensips: DBG:core:register_module: register_pv: tm Oct 20 14:54:49 opensips opensips: DBG:core:pv_add_extra: extra items list is not initialized Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/rr.so Oct 20 14:54:49 opensips opensips: DBG:core:register_module: register_pv: rr Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/maxfwd.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/usrloc.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/registrar.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/textops.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/mi_fifo.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/uri.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/acc.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/drouting.so Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <db_url> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <use_domain> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <probing_interval> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <probing_from> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <probing_method> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <probing_reply_codes> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: mi_fifo matches module mi_fifo Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <fifo_name> in module mi_fifo [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: rr matches module rr Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <append_fromtag> in module rr [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: usrloc matches module usrloc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <db_mode> in module usrloc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <early_media> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <report_cancels> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <detect_direction> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <failed_transaction_flag> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <log_flag> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <log_missed_flag> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <db_flag> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <db_missed_flag> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <mf_process_maxfwd_header>(1) in module maxfwd [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <has_totag>(0) in module uri [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <loose_route>(0) in module rr [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <record_route>(0) in module rr [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_check_trans>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_relay>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_check_trans>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_relay>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_check_trans>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <loose_route>(0) in module rr [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <record_route>(0) in module rr [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <append_hf>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <save>(1) in module registrar [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_reply_error>(0) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <lookup>(2) in module registrar [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_newtran>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_reply>(2) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_on_branch>(1) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_on_reply>(1) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_on_failure>(1) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_relay>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_reply_error>(0) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_was_cancelled>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <do_routing>(1) in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <send_reply>(2) in module signaling [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_on_failure>(1) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_was_cancelled>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_check_status>(1) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <use_next_gw>(0) in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_relay>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_reply>(2) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:socket2str: <udp:126.16.108.220:5060> Oct 20 14:54:49 opensips opensips: WARNING:core:main: no fork mode Oct 20 14:54:49 opensips opensips: DBG:core:fm_malloc_init: F_OPTIMIZE=16384, /ROUNDTO=2048 Oct 20 14:54:49 opensips opensips: DBG:core:fm_malloc_init: F_HASH_SIZE=2067, fm_block size=16568 Oct 20 14:54:49 opensips opensips: DBG:core:fm_malloc_init: params (0xb5723000, 33554432), start=0xb5723000 Oct 20 14:54:49 opensips opensips: DBG:core:shm_mem_init_mallocs: success Oct 20 14:54:49 opensips opensips: INFO:core:init_tcp: using epoll_lt as the TCP io watch method (auto detected) Oct 20 14:54:49 opensips opensips: DBG:core:set_core_dump: core dump limits set to 4294967295 Oct 20 14:54:49 opensips opensips: NOTICE:core:main: version: opensips 1.7.0-notls (i386/linux) Oct 20 14:54:49 opensips opensips: INFO:core:main: using 32 Mb shared memory Oct 20 14:54:49 opensips opensips: INFO:core:main: using 2 Mb private memory per process Oct 20 14:54:49 opensips opensips: DBG:core:new_avp_alias: added alias serial_branch with id 0 Oct 20 14:54:49 opensips opensips: DBG:core:init_stats_collector: statistics manager successfully initialized Oct 20 14:54:49 opensips opensips: DBG:core:evi_publish_event: Registered event <E_CORE_THRESHOLD(0)> Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module db_mysql Oct 20 14:54:49 opensips opensips: DBG:db_mysql:mysql_mod_init: mysql: MySQL client version is 5.1.54 Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module signaling Oct 20 14:54:49 opensips opensips: NOTICE:signaling:mod_init: initializing module ... Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <load_tm>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <load_sl>(0) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module sl Oct 20 14:54:49 opensips opensips: INFO:sl:mod_init: Initializing StateLess engine Oct 20 14:54:49 opensips opensips: DBG:core:MD5StringArray: MD5 calculated: 3def763471f3ad6ac39bd5b87643db16 Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: registering stats for sl Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module tm Oct 20 14:54:49 opensips opensips: INFO:tm:mod_init: TM - initializing... Oct 20 14:54:49 opensips opensips: DBG:tm:init_callid: Call-ID initialization: '2cfeb7a7' Oct 20 14:54:49 opensips opensips: DBG:tm:lock_initialize: lock initialization started Oct 20 14:54:49 opensips opensips: DBG:core:MD5StringArray: MD5 calculated: a360ab2e318cbb836634b261670593be Oct 20 14:54:49 opensips opensips: DBG:core:MD5StringArray: MD5 calculated: f3bf1e72cf8538d6125e6bc1854e6655 Oct 20 14:54:49 opensips opensips: DBG:core:register_pv_context: Registered new context: request / 0x37e0da Oct 20 14:54:49 opensips opensips: DBG:core:register_pv_context: Context not found Oct 20 14:54:49 opensips opensips: DBG:core:register_pv_context: Registered new context: reply / 0x37bcf8 Oct 20 14:54:49 opensips opensips: DBG:core:register_pv_context: Context not found Oct 20 14:54:49 opensips opensips: DBG:core:add_pv_context: Registered new context: reply Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: registering stats for tm Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: register MI for tm Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module rr Oct 20 14:54:49 opensips opensips: INFO:rr:mod_init: rr - initializing Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module maxfwd Oct 20 14:54:49 opensips opensips: INFO:maxfwd:mod_init: initializing... Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module usrloc Oct 20 14:54:49 opensips opensips: DBG:usrloc:mod_init: initializing Oct 20 14:54:49 opensips opensips: INFO:usrloc:ul_init_locks: locks array size 512 Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: registering stats for usrloc Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: register MI for usrloc Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module registrar Oct 20 14:54:49 opensips opensips: INFO:registrar:mod_init: initializing... Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <load_sig>(1) in module signaling [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <load_tm>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <ul_bind_usrloc>(1) in module usrloc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: registering stats for registrar Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module textops Oct 20 14:54:49 opensips opensips: INFO:textops:mod_init: initializing... Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module mi_fifo Oct 20 14:54:49 opensips opensips: DBG:mi_fifo:mi_mod_init: testing fifo existance ... Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module uri Oct 20 14:54:49 opensips opensips: DBG:uri:mod_init: initializing Oct 20 14:54:49 opensips opensips: DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:db_bind_mod: using db bind api for db_mysql Oct 20 14:54:49 opensips opensips: DBG:core:db_do_init: connection 0x81ebd50 not found in pool Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_connect: protocol version is 10 Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_connect: server version is 5.1.54-1ubuntu4 Oct 20 14:54:49 opensips opensips: DBG:core:db_do_init: connection 0x81ebd50 inserted in pool as 0x81ebe74 Oct 20 14:54:49 opensips opensips: DBG:core:db_new_result: allocate 28 bytes for result set at 0x81ebea8 Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Oct 20 14:54:49 opensips opensips: DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x81ebed4 Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x81ebed8)[0]=[table_version] Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query Oct 20 14:54:49 opensips opensips: DBG:core:db_table_version: no row for table subscriber found Oct 20 14:54:49 opensips opensips: ERROR:core:db_check_table_version: invalid version 0 for table subscriber found, expected 7 Oct 20 14:54:49 opensips opensips: ERROR:uri:mod_init: Invalid table version. Oct 20 14:54:49 opensips opensips: DBG:core:pool_remove: removing connection from the pool Oct 20 14:54:49 opensips opensips: ERROR:core:init_mod: failed to initialize module uri Oct 20 14:54:49 opensips opensips: ERROR:core:main: error while initializing modules Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: tm_shutdown : start Oct 20 14:54:49 opensips opensips: DBG:tm:unlink_timer_lists: emptying DELETE list Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: emptying hash table Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: releasing timers Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: removing semaphores Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: destroying callback lists Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: tm_shutdown : done Oct 20 14:54:49 opensips opensips: DBG:core:shm_mem_destroy: Oct 20 14:54:49 opensips opensips: DBG:core:shm_mem_destroy: destroying the shared memory lock

Obly errors: Oct 20 14:55:32 opensips opensips: ERROR:core:db_check_table_version: invalid version 0 for table subscriber found, expected 7 Oct 20 14:55:32 opensips opensips: ERROR:uri:mod_init: Invalid table version. Oct 20 14:55:32 opensips opensips: ERROR:core:init_mod: failed to initialize module uri Oct 20 14:55:32 opensips opensips: ERROR:core:main: error while initializing modules

(:nl:)>>messagehead<<

Rico?20 October 2011, 14:57

Sorry for last message :

 ERROR:core:db_check_table_version: invalid version 0 for table subscriber found, expected 7
 ERROR:uri:mod_init: Invalid table version.
 ERROR:core:init_mod: failed to initialize module uri
 ERROR:core:main: error while initializing modules

Opensips doen't start becose of this (module uri)..

Please help.

(:nl:)>>messagehead<<

Rico?20 October 2011, 14:57

Sorry for last message :

October 20, 2011, at 02:57 PM by Rico - Comment added
Added lines 838-852:
Rico?20 October 2011, 14:57

Sorry for last message :

 ERROR:core:db_check_table_version: invalid version 0 for table subscriber found, expected 7
 ERROR:uri:mod_init: Invalid table version.
 ERROR:core:init_mod: failed to initialize module uri
 ERROR:core:main: error while initializing modules

Opensips doen't start becose of this (module uri)..

Please help.

(:nl:)>>messagehead<<

October 20, 2011, at 02:57 PM by Rico - Comment added
Added lines 835-849:

(:nl:)>>messagehead<<

Rico?20 October 2011, 14:57

Sorry for last message :

 ERROR:core:db_check_table_version: invalid version 0 for table subscriber found, expected 7
 ERROR:uri:mod_init: Invalid table version.
 ERROR:core:init_mod: failed to initialize module uri
 ERROR:core:main: error while initializing modules

Opensips doen't start becose of this (module uri)..

Please help.

October 20, 2011, at 02:56 PM by Rico - Comment added
Added lines 634-834:

(:nl:)>>messagehead<<

Rico?20 October 2011, 14:56
  1. opensipsctl start

INFO: Starting OpenSIPS : ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/db_mysql.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/signaling.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/sl.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/tm.so Oct 20 14:54:49 opensips opensips: DBG:core:register_module: register_pv: tm Oct 20 14:54:49 opensips opensips: DBG:core:pv_add_extra: extra items list is not initialized Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/rr.so Oct 20 14:54:49 opensips opensips: DBG:core:register_module: register_pv: rr Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/maxfwd.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/usrloc.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/registrar.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/textops.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/mi_fifo.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/uri.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/acc.so Oct 20 14:54:49 opensips opensips: DBG:core:yyparse: loading module /usr/local/lib/opensips/modules/drouting.so Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <db_url> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <use_domain> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <probing_interval> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <probing_from> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <probing_method> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: drouting matches module drouting Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <probing_reply_codes> in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: mi_fifo matches module mi_fifo Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <fifo_name> in module mi_fifo [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: rr matches module rr Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <append_fromtag> in module rr [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: usrloc matches module usrloc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <db_mode> in module usrloc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <early_media> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <report_cancels> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <detect_direction> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <failed_transaction_flag> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <log_flag> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <log_missed_flag> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <db_flag> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: acc matches module acc Oct 20 14:54:49 opensips opensips: DBG:core:set_mod_param_regex: found <db_missed_flag> in module acc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <mf_process_maxfwd_header>(1) in module maxfwd [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <has_totag>(0) in module uri [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <loose_route>(0) in module rr [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <record_route>(0) in module rr [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_check_trans>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_relay>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_check_trans>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_relay>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_check_trans>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <loose_route>(0) in module rr [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <record_route>(0) in module rr [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <append_hf>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <save>(1) in module registrar [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_reply_error>(0) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <lookup>(2) in module registrar [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_newtran>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_reply>(2) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_send_reply>(2) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_on_branch>(1) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_on_reply>(1) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_on_failure>(1) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_relay>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <sl_reply_error>(0) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_was_cancelled>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <do_routing>(1) in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <send_reply>(2) in module signaling [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <is_method>(1) in module textops [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_on_failure>(1) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_was_cancelled>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_check_status>(1) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <use_next_gw>(0) in module drouting [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_relay>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <t_reply>(2) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:socket2str: <udp:126.16.108.220:5060> Oct 20 14:54:49 opensips opensips: WARNING:core:main: no fork mode Oct 20 14:54:49 opensips opensips: DBG:core:fm_malloc_init: F_OPTIMIZE=16384, /ROUNDTO=2048 Oct 20 14:54:49 opensips opensips: DBG:core:fm_malloc_init: F_HASH_SIZE=2067, fm_block size=16568 Oct 20 14:54:49 opensips opensips: DBG:core:fm_malloc_init: params (0xb5723000, 33554432), start=0xb5723000 Oct 20 14:54:49 opensips opensips: DBG:core:shm_mem_init_mallocs: success Oct 20 14:54:49 opensips opensips: INFO:core:init_tcp: using epoll_lt as the TCP io watch method (auto detected) Oct 20 14:54:49 opensips opensips: DBG:core:set_core_dump: core dump limits set to 4294967295 Oct 20 14:54:49 opensips opensips: NOTICE:core:main: version: opensips 1.7.0-notls (i386/linux) Oct 20 14:54:49 opensips opensips: INFO:core:main: using 32 Mb shared memory Oct 20 14:54:49 opensips opensips: INFO:core:main: using 2 Mb private memory per process Oct 20 14:54:49 opensips opensips: DBG:core:new_avp_alias: added alias serial_branch with id 0 Oct 20 14:54:49 opensips opensips: DBG:core:init_stats_collector: statistics manager successfully initialized Oct 20 14:54:49 opensips opensips: DBG:core:evi_publish_event: Registered event <E_CORE_THRESHOLD(0)> Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module db_mysql Oct 20 14:54:49 opensips opensips: DBG:db_mysql:mysql_mod_init: mysql: MySQL client version is 5.1.54 Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module signaling Oct 20 14:54:49 opensips opensips: NOTICE:signaling:mod_init: initializing module ... Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <load_tm>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <load_sl>(0) in module sl [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module sl Oct 20 14:54:49 opensips opensips: INFO:sl:mod_init: Initializing StateLess engine Oct 20 14:54:49 opensips opensips: DBG:core:MD5StringArray: MD5 calculated: 3def763471f3ad6ac39bd5b87643db16 Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: registering stats for sl Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module tm Oct 20 14:54:49 opensips opensips: INFO:tm:mod_init: TM - initializing... Oct 20 14:54:49 opensips opensips: DBG:tm:init_callid: Call-ID initialization: '2cfeb7a7' Oct 20 14:54:49 opensips opensips: DBG:tm:lock_initialize: lock initialization started Oct 20 14:54:49 opensips opensips: DBG:core:MD5StringArray: MD5 calculated: a360ab2e318cbb836634b261670593be Oct 20 14:54:49 opensips opensips: DBG:core:MD5StringArray: MD5 calculated: f3bf1e72cf8538d6125e6bc1854e6655 Oct 20 14:54:49 opensips opensips: DBG:core:register_pv_context: Registered new context: request / 0x37e0da Oct 20 14:54:49 opensips opensips: DBG:core:register_pv_context: Context not found Oct 20 14:54:49 opensips opensips: DBG:core:register_pv_context: Registered new context: reply / 0x37bcf8 Oct 20 14:54:49 opensips opensips: DBG:core:register_pv_context: Context not found Oct 20 14:54:49 opensips opensips: DBG:core:add_pv_context: Registered new context: reply Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: registering stats for tm Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: register MI for tm Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module rr Oct 20 14:54:49 opensips opensips: INFO:rr:mod_init: rr - initializing Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module maxfwd Oct 20 14:54:49 opensips opensips: INFO:maxfwd:mod_init: initializing... Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module usrloc Oct 20 14:54:49 opensips opensips: DBG:usrloc:mod_init: initializing Oct 20 14:54:49 opensips opensips: INFO:usrloc:ul_init_locks: locks array size 512 Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: registering stats for usrloc Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: register MI for usrloc Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module registrar Oct 20 14:54:49 opensips opensips: INFO:registrar:mod_init: initializing... Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <load_sig>(1) in module signaling [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <load_tm>(0) in module tm [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found <ul_bind_usrloc>(1) in module usrloc [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: registering stats for registrar Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module textops Oct 20 14:54:49 opensips opensips: INFO:textops:mod_init: initializing... Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module mi_fifo Oct 20 14:54:49 opensips opensips: DBG:mi_fifo:mi_mod_init: testing fifo existance ... Oct 20 14:54:49 opensips opensips: DBG:core:init_mod: initializing module uri Oct 20 14:54:49 opensips opensips: DBG:uri:mod_init: initializing Oct 20 14:54:49 opensips opensips: DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/local/lib/opensips/modules/] Oct 20 14:54:49 opensips opensips: DBG:core:db_bind_mod: using db bind api for db_mysql Oct 20 14:54:49 opensips opensips: DBG:core:db_do_init: connection 0x81ebd50 not found in pool Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_connect: protocol version is 10 Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_connect: server version is 5.1.54-1ubuntu4 Oct 20 14:54:49 opensips opensips: DBG:core:db_do_init: connection 0x81ebd50 inserted in pool as 0x81ebe74 Oct 20 14:54:49 opensips opensips: DBG:core:db_new_result: allocate 28 bytes for result set at 0x81ebea8 Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Oct 20 14:54:49 opensips opensips: DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x81ebed4 Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x81ebed8)[0]=[table_version] Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Oct 20 14:54:49 opensips opensips: DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query Oct 20 14:54:49 opensips opensips: DBG:core:db_table_version: no row for table subscriber found Oct 20 14:54:49 opensips opensips: ERROR:core:db_check_table_version: invalid version 0 for table subscriber found, expected 7 Oct 20 14:54:49 opensips opensips: ERROR:uri:mod_init: Invalid table version. Oct 20 14:54:49 opensips opensips: DBG:core:pool_remove: removing connection from the pool Oct 20 14:54:49 opensips opensips: ERROR:core:init_mod: failed to initialize module uri Oct 20 14:54:49 opensips opensips: ERROR:core:main: error while initializing modules Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: tm_shutdown : start Oct 20 14:54:49 opensips opensips: DBG:tm:unlink_timer_lists: emptying DELETE list Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: emptying hash table Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: releasing timers Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: removing semaphores Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: destroying callback lists Oct 20 14:54:49 opensips opensips: DBG:tm:tm_shutdown: tm_shutdown : done Oct 20 14:54:49 opensips opensips: DBG:core:shm_mem_destroy: Oct 20 14:54:49 opensips opensips: DBG:core:shm_mem_destroy: destroying the shared memory lock

Obly errors: Oct 20 14:55:32 opensips opensips: ERROR:core:db_check_table_version: invalid version 0 for table subscriber found, expected 7 Oct 20 14:55:32 opensips opensips: ERROR:uri:mod_init: Invalid table version. Oct 20 14:55:32 opensips opensips: ERROR:core:init_mod: failed to initialize module uri Oct 20 14:55:32 opensips opensips: ERROR:core:main: error while initializing modules

August 11, 2011, at 08:37 PM by manish - Comment added
Added lines 596-633:

(:nl:)>>messagehead<<

manish11 August 2011, 20:37

also my log messages gives the following Aug 12 00:04:44 ADHIRAAJ opensips: INFO:core:init_tcp: using epoll_lt as the TCP io watch method (auto detected) Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: NOTICE:core:main: version: opensips 1.5.0-tls (i386/linux) Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:core:main: using 64 Mb shared memory Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:core:main: using 1 Mb private memory per process Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: NOTICE:signaling:mod_init: initializing module ... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:sl:mod_init: Initializing StateLess engine Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:tm:mod_init: TM - initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:maxfwd:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:usrloc:ul_init_locks: locks array size 512 Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:registrar:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:textops:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:xlog:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:acc:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:auth:mod_init: initializing... Aug 12 00:04:44 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:auth_db:mod_init: initializing... Aug 12 00:04:45 ADHIRAAJ /usr/local/sbin/opensips[19285]: INFO:core:probe_max_receive_buffer: using a UDP receive buffer of 255 kb Aug 12 00:05:06 ADHIRAAJ opensips: INFO:core:init_tcp: using epoll_lt as the TCP io watch method (auto detected) Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: NOTICE:core:main: version: opensips 1.5.0-tls (i386/linux) Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:core:main: using 32 Mb shared memory Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:core:main: using 1 Mb private memory per process Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: NOTICE:signaling:mod_init: initializing module ... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:sl:mod_init: Initializing StateLess engine Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:tm:mod_init: TM - initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:maxfwd:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:usrloc:ul_init_locks: locks array size 512 Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:registrar:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:textops:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:xlog:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:acc:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:auth:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:auth_db:mod_init: initializing... Aug 12 00:05:06 ADHIRAAJ /usr/local/sbin/opensips[19306]: INFO:core:probe_max_receive_buffer: using a UDP receive buffer of 255 kb

August 11, 2011, at 08:30 PM by manish - Comment added
Added lines 565-594:

(:nl:)>>messagehead<<

manish11 August 2011, 20:30

Dear Bogdan i am getting following error after i start opensips ERROR: No PID file found (/var/run/opensips/opensips.pid)! OpenSIPS probably not running

can i create pid file in the /var/run/opensips how to check that opensips is running

if i run sudo /etc/init.d/opensips start it gives me Starting opensips: opensipsListening on

             udp: 127.0.0.1 [127.0.0.1]:5060
             udp: 10.0.0.5 [10.0.0.5]:5060
             tcp: 127.0.0.1 [127.0.0.1]:5060
             tcp: 10.0.0.5 [10.0.0.5]:5060

Aliases:

             tcp: ADHIRAAJ.local:5060
             tcp: localhost:5060
             udp: ADHIRAAJ.local:5060
             udp: localhost:5060

but with ps ax command it doesnt show me that opensip is running

pl help

August 03, 2011, at 08:21 PM by prabb - Comment added
Added lines 479-565:

(:nl:)>>messagehead<<

prabb?03 August 2011, 20:21

If someone could write a manual for a CentOS install, it might look like CENTOS 5 INSTALL 1. Prequisites include all dependency installs of centOS5, linux LAMP and asterisk; don't install asterisk.

2. A system user will need to be added to install opensips with nologin. adduser opensips nologin.

3. Download all opensips packages from opensips. rpms for CentOS are found at SourceForge. As of mid 2011: opensips-1.7.0-0.i386.rpm opensips-b2bua-1.7.0-0.i386.rpm opensips-cpl-1.7.0-0.i386.rpm opensips-debuginfo-1.7.0-0.i386.rpm opensips-jabber-1.4.5-0.i386.rpm opensips-mysql-1.7.0-0.i386.rpm

4. Download perl-Frontier-RPC. This was found at pbone.net linked to daag. perl-Frontier-RPC-0.07b4-1.el5.rf.noarch.rpm. rpm -i perl-Frontier-RPC..etc

5. rpm -i opensips-1.7 (base). Then mysql and the rest.

6. At /etc/default/opensips, ensure the following is uncommented:

  1. Set to yes to enable opensips, once configured properly.

RUN_OPENSIPS=yes

  1. User to run as

USER=opensips

  1. Group to run as

GROUP=opensips

7. Now opensips should be able to be daemonized. chkconfig opensips on service opensips start (stop / restart / status)

8. At /etc/opensips/opensips.cfg, uncomment as follows: /* uncomment the next line to disable TCP (default on) */ disable_tcp=yes

  1. default db_url to be used by modules requiring DB connection

db_default_url="mysql://opensips:opensipsrw@localhost/opensips"

/* uncomment next line for MySQL DB support */

9. At /etc/opensips/opensipsctlrc, uncomment as follows:

  1. If you want to setup a database with opensipsdbctl, you must at least specify
  2. this parameter.

DBENGINE=MYSQL

  1. database host

DBHOST=localhost

  1. database name (for ORACLE this is TNS name)

DBNAME=opensips

  1. database path used by dbtext or db_berkeley
  2. DB_PATH="/usr/local/etc/opensips/dbtext"
    1. database read/write user

DBRWUSER=opensips

  1. password for database read/write user

DBRWPW="password"

  1. database super user (for ORACLE this is 'scheme-creator' user)

DBROOTUSER="root"

  1. user name column

USERCOL="username"

10. Now at /etc/opensips/ you should be able to run the following command to create a database from script: opensipsdbctl create the process is interactive.

11. service restart opensips. [OK] doesn't usually appear, status shows it running.

you're welcome.

August 02, 2011, at 11:53 PM by prabb - Comment added
Added lines 473-478:

(:nl:)>>messagehead<<

prabb?02 August 2011, 23:53

Probably what you should have said at the head of the document, is: "create a system user with linux adduser command and nologin. Example: adduser opensips nologin.

July 07, 2011, at 12:28 PM by sipsip - Comment added
Added lines 457-472:

(:nl:)>>messagehead<<

sipsip?07 July 2011, 12:28

Dear Bogdan I tried to set up opensips 1.6.2 but i alwyes get this error

root@debtest:~# opensipsctl start -e E[37;32mWARNING: database engine not found - tried 'MYSQL' -e Control engine 'FIFO' loaded

-e E[37;33mINFO: Starting OpenSIPS : -e E[37;33mINFO: started (pid: 1693) i spent much time searching this error but find nothing , can u help me how to solve this problem ?

June 27, 2011, at 05:04 PM by 109.99.2.142 -
Deleted lines 456-461:

(:nl:)>>messagehead<<

Caden?27 June 2011, 02:04

I thank you humbly for sharing your wiosdm JJWY

June 27, 2011, at 02:04 AM by Caden - Comment added
Added lines 457-462:

(:nl:)>>messagehead<<

Caden?27 June 2011, 02:04

I thank you humbly for sharing your wiosdm JJWY

May 23, 2011, at 10:30 AM by bogdan -
Added lines 455-456:

[bogdan] - either another opensips instance, either another application is listening on the same tcp:IP:PORT as you configured your opensips - check with "netstat -tlnp"

May 21, 2011, at 10:30 AM by lisongchao - Comment added
Added lines 441-454:

(:nl:)>>messagehead<<

lisongchao?21 May 2011, 10:30

ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

and when I check /var/log/messages that show

May 21 16:26:47 linux5-uc last message repeated 2 times May 21 16:26:47 linux5-uc ./opensips[8549]: ERROR:core:tcp_init: bind(8, 0x81be074, 16) on 127.0.0.1:5060 : Address already in use

help help and what's the problem???

April 12, 2011, at 01:13 PM by bogdan -
Added lines 360-361:

[bogdan] - use "adduser" and "addgroup" system commands

Added lines 406-407:

[bogdan] - check the log files (see the page content) for opensips errors - most probably your opensips fails to start.

Added lines 439-440:

[bogdan] - check the log files (see the page content) for opensips errors - most probably your opensips fails to start.

April 11, 2011, at 10:12 PM by Bhavik Pandya - Comment added
Added lines 412-434:

(:nl:)>>messagehead<<

Bhavik Pandya?11 April 2011, 22:12

bhavik@prithvi:~$ opensipsctl restart

[: 2443: restart: unexpected operator -e E[37;33mINFO: Stopping OpenSIPS :

-e E[37;31mERROR: No PID file found (/var/run/opensips.pid)! OpenSIPS probably not running

-e E[37;33mINFO: Starting OpenSIPS :

-e E[37;31mERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

-- I have checked my user name and password, its the same in opensips.cfg file and mysql. -- The /var/run directory has full permissions -- I also have done sudo opensipsctl restart, thus trying to login as a root -- I tried to create a new account in mysql, but still couldnot solve this problem...

Any help will be appreciated...

February 22, 2011, at 07:41 PM by Naser - Comment added
Added lines 404-411:

(:nl:)>>messagehead<<

Naser ?22 February 2011, 19:41

I have similar problem, when i start opensips it works and give the message of listening, but when i check the status of opensips it say, opensips not running, anyone has idea about the problem,

January 28, 2011, at 10:55 AM by Mahmut Cahmut - Comment added
Added lines 393-403:

(:nl:)>>messagehead<<

Mahmut Cahmut?28 January 2011, 10:55

dhcppc:~# opensipsctl start

INFO: Starting OpenSIPS :

ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed any solution for this issue ?

January 13, 2011, at 11:24 AM by sipsip - Comment added
Added lines 360-392:

(:nl:)>>messagehead<<

sipsip?13 January 2011, 11:24

this is my /etc/default/opesips

  1. OpenSIPS startup options
  2. Set to yes to enable opensips, once configured properly.

RUN_OPENSIPS=yes

  1. User to run as

USER=opensips

  1. Group to run as

GROUP=opensips

  1. Amount of memory to allocate for the running OpenSIPS server (in Mb)

MEMORY=128

  1. Enable the server to leave a core file when it crashes.
  2. Set this to 'yes' to enable OpenSIPS to leave a core file when it crashes
  3. or 'no' to disable this feature. This option is case sensitive and only
  4. accepts 'yes' and 'no' and only in lowercase letters.
  5. On some systems (e.g. Ubuntu 6.10, Debian 4.0) it is necessary to specify
  6. a directory for the core files to get a dump. Look into the opensips
  7. init file for an example configuration.

DUMP_CORE=no

so, where is the problem??

January 13, 2011, at 11:13 AM by sipsip - Comment added
Added lines 349-359:

(:nl:)>>messagehead<<

sipsip?13 January 2011, 11:13

Dear Bogdan ,

When i run OpensISPS, iam getting the following error

 /etc/init.d/opensips start
 *chown: `opensips:opensips': invalid user
  • Please help How to create the "opensips" user and "opensips" group on your system ??
November 10, 2010, at 09:09 AM by bogdan -
Added lines 302-304:

[bogdan] - in opensips cfg, the db_url for usrloc module is not correctly set.

Changed lines 307-308 from:

(:nl:)>>messagehead<<

23 August 2010, 06:05
to:

(:nl:)>>messagehead<<

Chrispy?01 September 2010, 01:46
Changed lines 311-649 from:

e Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e878)[2]=[mask] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e880)[3]=[port] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e888)[4]=[proto] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e890)[5]=[pattern] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e898)[6]=[context_info] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e8a0)[7]=[id] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query Aug 22 23:56:16 [27826] DBG:permissions:reload_address_table: number of rows in address table: 0 Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:permissions:reload_address_table: address table reloaded successfully. Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for permissions Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module group Aug 22 23:56:16 [27826] DBG:group:mod_init: group module - initializing Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x816d0e4 Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x816cf14)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [3] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x816d164 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x816d15c Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:group:mod_init: group database loaded Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module drouting Aug 22 23:56:16 [27826] INFO:drouting:dr_init: Dynamic-Routing - initializing Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:find_cmd_export_t: found <load_tm>(0) in module tm [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for drouting Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module avpops Aug 22 23:56:16 [27826] INFO:avpops:avpops_init: initializing... Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module dialplan Aug 22 23:56:16 [27826] INFO:dialplan:mod_init: initializing module... Aug 22 23:56:16 [27826] DBG:dialplan:mod_init: db_url=mysql://opensips:opensipsrw@localhost/opensips/46/0x8276ca8 Aug 22 23:56:16 [27826] DBG:dialplan:init_data: trying to initialize data from db Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x816d0e4 Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x816cf14)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x816d188 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [2] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x816d190 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x816d188 Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:dialplan:dp_load_db: init Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 8 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 128 bytes for result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e868)[0]=[dpid] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e870)[1]=[pr] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e878)[2]=[match_op] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e880)[3]=[match_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e888)[4]=[match_len] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e890)[5]=[subst_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e898)[6]=[repl_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e8a0)[7]=[attrs] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_fetch_result: no rows returned from the query Aug 22 23:56:16 [27826] WARNING:dialplan:dp_load_db: no data in the db Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for dialplan Aug 22 23:56:16 [27826] DBG:core:count_module_procs: modules require 1 extra processes Aug 22 23:56:16 [27826] DBG:core:init_pkg_stats: setting stats for 19 processes Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing mf_process_maxfwd_header, line 279 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 280 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing has_totag, line 284 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing loose_route, line 287 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 288 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x8 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [BYE/8] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 291 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing record_route, line 295 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 309 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x4 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [ACK/4] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 310 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 313 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 321 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 329 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [CANCEL/2] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 331 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 332 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 336 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_from_local, line 341 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing check_source_address, line 344 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing proxy_authorize, line 345 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x817e96c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817e93c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817e9a0 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e9a4)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817e9bc Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [7] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e9a0 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817e9c4 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817e9bc Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817e93c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing proxy_challenge, line 346 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing db_check_from, line 349 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 350 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing consume_credentials, line 354 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing loose_route, line 360 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 362 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 363 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x4 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [ACK/4] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 364 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 369 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x180 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for methods [REGISTER,MESSAGE/384] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing record_route, line 370 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 373 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing append_hf, line 380 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 397 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2200 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for methods [PUBLISH,SUBSCRIBE/8704] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 407 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x80 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [REGISTER/128] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing www_authorize, line 410 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x817e93c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x817e93c inserted in pool as 0x817ec9c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ec6c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817ecd0 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817ecd4)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [7] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817ecd0 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817ecf4 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ec6c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing www_challenge, line 412 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing db_check_to, line 416 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 418 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing save, line 422 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816d188 not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816d188 inserted in pool as 0x817ec9c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817e96c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e970)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817ed64 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [1005] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e96c Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817ed6c Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817ed64 Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817ed64 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817ed68)[0]=[username] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817ed64 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 423 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 430 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing alias_db_lookup, line 435 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_db_load, line 436 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 439 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_print, line 439 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing dp_translate, line 444 Aug 22 23:56:16 [27826] DBG:dialplan:dp_trans_fixup: param_no is 1 Aug 22 23:56:16 [27826] DBG:dialplan:dp_trans_fixup: param_no is 2 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 445 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 448 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 466 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 474 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_branch, line 475 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_reply, line 476 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_failure, line 477 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 480 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 481 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_newtran, line 492 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 494 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 498 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2000 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [PUBLISH/8192] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing handle_publish, line 500 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing lookup, line 526 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_db_query, line 531 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_newtran, line 533 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_reply, line 534 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 540 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 545 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing do_routing, line 557 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 558 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 568 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 576 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 579 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 587 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_was_cancelled, line 590 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing use_next_gw, line 594 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_failure, line 596 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 597 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_reply, line 601 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_status, line 607 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 611 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_status, line 615 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 619 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_was_cancelled, line 622 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 583 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: getsockopt SO_RCVBUF is initially 111616 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 223232 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=223232,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 225280 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=225280,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 227328 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=227328,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 229376 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=229376,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 231424 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=231424,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 233472 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=233472,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 235520 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=235520,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 237568 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=237568,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 239616 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=239616,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 241664 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=241664,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 243712 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=243712,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 245760 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=245760,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 247808 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=247808,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 249856 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=249856,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 251904 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=251904,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 253952 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=253952,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 256000 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=256000,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 258048 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=258048,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 260096 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=260096,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 262144 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=262144,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF has no effect Aug 22 23:56:16 [27826] INFO:core:probe_max_receive_buffer: using a UDP receive buffer of 255 kb Aug 22 23:56:16 [27826] ERROR:core:udp_init: bind(4, 0x816d410, 16) on 192.168.152.148: Cannot assign requested address Aug 22 23:56:16 [27826] DBG:presence_xml:destroy: start Aug 22 23:56:16 [27826] DBG:presence_mwi:destroy: destroying module ... Aug 22 23:56:16 [27826] NOTICE:presence:destroy: destroy module ... Aug 22 23:56:16 [27826] DBG:xlog:destroy: destroy module... Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: tm_shutdown : start Aug 22 23:56:16 [27826] DBG:tm:unlink_timer_lists: emptying DELETE list Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: emptying hash table Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: releasing timers Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: removing semaphores Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: destroying callback lists Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: tm_shutdown : done Aug 22 23:56:16 [27826] DBG:core:shm_mem_destroy: Aug 22 23:56:16 [27826] DBG:core:shm_mem_destroy: destroying the shared memory lock

hi am having so problems with my opensips can you have a look please kind regards

to:

Here's a weird one. I have OpenSIPS up and running fine for over a month. It responds and mi is talking via xmlrpc to OpenSIPS-CP just fine. I start it up using chkconfig with the startup script I found on opensips.org for CentOS (/etc/init.d/opensips).

The weird thing is that despite starting fine, opensips doesn't create a pid file in /var/run (or anywhere else.) I just noticed this because I'm trying to setup Monit on the opensips box, and it wants to see the pid file.

Can't be rights, I opened up /var and /var/run with chmod 777 just to ensure.

CentOS 5.5, uname -a reports: 2.6.18-194.8.1.el5PAE OpenSIPS 1.6.2

[bogdan] - do you start opensips with -p param to point to a PD file ?

Changed lines 323-324 from:

(:nl:)>>messagehead<<

23 August 2010, 06:05
to:

(:nl:)>>messagehead<<

jm21?20 September 2010, 22:22
Deleted lines 325-681:

e Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e878)[2]=[mask] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e880)[3]=[port] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e888)[4]=[proto] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e890)[5]=[pattern] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e898)[6]=[context_info] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e8a0)[7]=[id] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query Aug 22 23:56:16 [27826] DBG:permissions:reload_address_table: number of rows in address table: 0 Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:permissions:reload_address_table: address table reloaded successfully. Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for permissions Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module group Aug 22 23:56:16 [27826] DBG:group:mod_init: group module - initializing Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x816d0e4 Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x816cf14)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [3] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x816d164 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x816d15c Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:group:mod_init: group database loaded Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module drouting Aug 22 23:56:16 [27826] INFO:drouting:dr_init: Dynamic-Routing - initializing Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:find_cmd_export_t: found <load_tm>(0) in module tm [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for drouting Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module avpops Aug 22 23:56:16 [27826] INFO:avpops:avpops_init: initializing... Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module dialplan Aug 22 23:56:16 [27826] INFO:dialplan:mod_init: initializing module... Aug 22 23:56:16 [27826] DBG:dialplan:mod_init: db_url=mysql://opensips:opensipsrw@localhost/opensips/46/0x8276ca8 Aug 22 23:56:16 [27826] DBG:dialplan:init_data: trying to initialize data from db Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x816d0e4 Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x816cf14)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x816d188 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [2] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x816d190 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x816d188 Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:dialplan:dp_load_db: init Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 8 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 128 bytes for result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e868)[0]=[dpid] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e870)[1]=[pr] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e878)[2]=[match_op] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e880)[3]=[match_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e888)[4]=[match_len] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e890)[5]=[subst_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e898)[6]=[repl_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e8a0)[7]=[attrs] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_fetch_result: no rows returned from the query Aug 22 23:56:16 [27826] WARNING:dialplan:dp_load_db: no data in the db Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for dialplan Aug 22 23:56:16 [27826] DBG:core:count_module_procs: modules require 1 extra processes Aug 22 23:56:16 [27826] DBG:core:init_pkg_stats: setting stats for 19 processes Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing mf_process_maxfwd_header, line 279 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 280 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing has_totag, line 284 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing loose_route, line 287 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 288 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x8 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [BYE/8] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 291 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing record_route, line 295 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 309 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x4 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [ACK/4] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 310 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 313 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 321 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 329 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [CANCEL/2] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 331 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 332 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 336 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_from_local, line 341 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing check_source_address, line 344 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing proxy_authorize, line 345 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x817e96c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817e93c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817e9a0 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e9a4)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817e9bc Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [7] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e9a0 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817e9c4 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817e9bc Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817e93c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing proxy_challenge, line 346 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing db_check_from, line 349 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 350 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing consume_credentials, line 354 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing loose_route, line 360 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 362 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 363 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x4 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [ACK/4] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 364 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 369 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x180 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for methods [REGISTER,MESSAGE/384] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing record_route, line 370 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 373 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing append_hf, line 380 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 397 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2200 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for methods [PUBLISH,SUBSCRIBE/8704] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 407 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x80 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [REGISTER/128] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing www_authorize, line 410 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x817e93c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x817e93c inserted in pool as 0x817ec9c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ec6c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817ecd0 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817ecd4)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [7] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817ecd0 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817ecf4 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ec6c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing www_challenge, line 412 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing db_check_to, line 416 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 418 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing save, line 422 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816d188 not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816d188 inserted in pool as 0x817ec9c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817e96c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e970)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817ed64 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [1005] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e96c Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817ed6c Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817ed64 Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817ed64 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817ed68)[0]=[username] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817ed64 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 423 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 430 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing alias_db_lookup, line 435 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_db_load, line 436 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 439 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_print, line 439 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing dp_translate, line 444 Aug 22 23:56:16 [27826] DBG:dialplan:dp_trans_fixup: param_no is 1 Aug 22 23:56:16 [27826] DBG:dialplan:dp_trans_fixup: param_no is 2 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 445 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 448 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 466 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 474 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_branch, line 475 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_reply, line 476 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_failure, line 477 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 480 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 481 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_newtran, line 492 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 494 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 498 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2000 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [PUBLISH/8192] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing handle_publish, line 500 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing lookup, line 526 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_db_query, line 531 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_newtran, line 533 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_reply, line 534 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 540 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 545 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing do_routing, line 557 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 558 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 568 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 576 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 579 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 587 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_was_cancelled, line 590 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing use_next_gw, line 594 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_failure, line 596 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 597 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_reply, line 601 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_status, line 607 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 611 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_status, line 615 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 619 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_was_cancelled, line 622 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 583 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: getsockopt SO_RCVBUF is initially 111616 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 223232 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=223232,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 225280 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=225280,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 227328 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=227328,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 229376 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=229376,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 231424 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=231424,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 233472 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=233472,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 235520 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=235520,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 237568 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=237568,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 239616 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=239616,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 241664 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=241664,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 243712 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=243712,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 245760 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=245760,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 247808 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=247808,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 249856 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=249856,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 251904 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=251904,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 253952 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=253952,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 256000 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=256000,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 258048 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=258048,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 260096 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=260096,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 262144 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=262144,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF has no effect Aug 22 23:56:16 [27826] INFO:core:probe_max_receive_buffer: using a UDP receive buffer of 255 kb Aug 22 23:56:16 [27826] ERROR:core:udp_init: bind(4, 0x816d410, 16) on 192.168.152.148: Cannot assign requested address Aug 22 23:56:16 [27826] DBG:presence_xml:destroy: start Aug 22 23:56:16 [27826] DBG:presence_mwi:destroy: destroying module ... Aug 22 23:56:16 [27826] NOTICE:presence:destroy: destroy module ... Aug 22 23:56:16 [27826] DBG:xlog:destroy: destroy module... Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: tm_shutdown : start Aug 22 23:56:16 [27826] DBG:tm:unlink_timer_lists: emptying DELETE list Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: emptying hash table Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: releasing timers Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: removing semaphores Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: destroying callback lists Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: tm_shutdown : done Aug 22 23:56:16 [27826] DBG:core:shm_mem_destroy: Aug 22 23:56:16 [27826] DBG:core:shm_mem_destroy: destroying the shared memory lock

hi am having so problems with my opensips can you have a look please kind regards

(:nl:)>>messagehead<<

Chrispy?01 September 2010, 01:46

Here's a weird one. I have OpenSIPS up and running fine for over a month. It responds and mi is talking via xmlrpc to OpenSIPS-CP just fine. I start it up using chkconfig with the startup script I found on opensips.org for CentOS (/etc/init.d/opensips).

The weird thing is that despite starting fine, opensips doesn't create a pid file in /var/run (or anywhere else.) I just noticed this because I'm trying to setup Monit on the opensips box, and it wants to see the pid file.

Can't be rights, I opened up /var and /var/run with chmod 777 just to ensure.

CentOS 5.5, uname -a reports: 2.6.18-194.8.1.el5PAE OpenSIPS 1.6.2

(:nl:)>>messagehead<<

jm21?20 September 2010, 22:22
Changed line 337 from:

Sep 20 15:52:22 CL-T020-483CL opensips: INFO:core:probe_max_receive_buffer: usin g a UDP receive buffer of 255 kb

to:

Sep 20 15:52:22 CL-T020-483CL opensips: INFO:core:probe_max_receive_buffer: using a UDP receive buffer of 255 kb

Changed line 348 from:
to:

[bogdan] - signal 2 is SIGINT - looks like your opensips is terminated by other app.

September 20, 2010, at 10:22 PM by jm21 - Comment added
Added lines 1003-1030:

(:nl:)>>messagehead<<

jm21?20 September 2010, 22:22

Hi, I've setup Opensips with mysql support but am having issues getting it to start. i get the following error:

ERROR: No PID file found (/var/run/opensips.pid)! OpenSIPS probably not running INFO: check with 'ps -ef | /bin/egrep opensips'

when i do a tail /var/log/messages i get the following:

Sep 20 15:52:22 CL-T020-483CL opensips: INFO:acc:mod_init: initializing... Sep 20 15:52:22 CL-T020-483CL opensips: INFO:auth:mod_init: initializing... Sep 20 15:52:22 CL-T020-483CL opensips: INFO:auth_db:mod_init: initializing... Sep 20 15:52:22 CL-T020-483CL opensips: INFO:core:probe_max_receive_buffer: usin g a UDP receive buffer of 255 kb Sep 20 16:13:14 CL-T020-483CL opensips: INFO:core:sig_usr: signal 2 received Sep 20 16:13:14 CL-T020-483CL last message repeated 2 times Sep 20 16:13:14 CL-T020-483CL opensips: INFO:core:handle_sigs: child process 585 6 exited normally, status=0 Sep 20 16:13:14 CL-T020-483CL opensips: INFO:core:handle_sigs: child process 585 7 exited normally, status=0 Sep 20 16:13:14 CL-T020-483CL opensips: INFO:core:handle_sigs: terminating due t o SIGCHLD Sep 20 16:13:14 CL-T020-483CL opensips: INFO:core:sig_usr: signal 15 received

Does anyone have an idea of whats wrong or what i could be doing wrong?

September 01, 2010, at 01:46 AM by Chrispy - Comment added
Added lines 990-1002:

(:nl:)>>messagehead<<

Chrispy?01 September 2010, 01:46

Here's a weird one. I have OpenSIPS up and running fine for over a month. It responds and mi is talking via xmlrpc to OpenSIPS-CP just fine. I start it up using chkconfig with the startup script I found on opensips.org for CentOS (/etc/init.d/opensips).

The weird thing is that despite starting fine, opensips doesn't create a pid file in /var/run (or anywhere else.) I just noticed this because I'm trying to setup Monit on the opensips box, and it wants to see the pid file.

Can't be rights, I opened up /var and /var/run with chmod 777 just to ensure.

CentOS 5.5, uname -a reports: 2.6.18-194.8.1.el5PAE OpenSIPS 1.6.2

August 23, 2010, at 06:05 AM by olasuleimonhotmailcom - Comment added
Added lines 305-648:
23 August 2010, 06:05

e Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e878)[2]=[mask] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e880)[3]=[port] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e888)[4]=[proto] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e890)[5]=[pattern] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e898)[6]=[context_info] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e8a0)[7]=[id] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query Aug 22 23:56:16 [27826] DBG:permissions:reload_address_table: number of rows in address table: 0 Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:permissions:reload_address_table: address table reloaded successfully. Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for permissions Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module group Aug 22 23:56:16 [27826] DBG:group:mod_init: group module - initializing Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x816d0e4 Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x816cf14)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [3] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x816d164 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x816d15c Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:group:mod_init: group database loaded Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module drouting Aug 22 23:56:16 [27826] INFO:drouting:dr_init: Dynamic-Routing - initializing Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:find_cmd_export_t: found <load_tm>(0) in module tm [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for drouting Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module avpops Aug 22 23:56:16 [27826] INFO:avpops:avpops_init: initializing... Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module dialplan Aug 22 23:56:16 [27826] INFO:dialplan:mod_init: initializing module... Aug 22 23:56:16 [27826] DBG:dialplan:mod_init: db_url=mysql://opensips:opensipsrw@localhost/opensips/46/0x8276ca8 Aug 22 23:56:16 [27826] DBG:dialplan:init_data: trying to initialize data from db Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x816d0e4 Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x816cf14)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x816d188 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [2] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x816d190 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x816d188 Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:dialplan:dp_load_db: init Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 8 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 128 bytes for result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e868)[0]=[dpid] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e870)[1]=[pr] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e878)[2]=[match_op] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e880)[3]=[match_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e888)[4]=[match_len] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e890)[5]=[subst_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e898)[6]=[repl_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e8a0)[7]=[attrs] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_fetch_result: no rows returned from the query Aug 22 23:56:16 [27826] WARNING:dialplan:dp_load_db: no data in the db Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for dialplan Aug 22 23:56:16 [27826] DBG:core:count_module_procs: modules require 1 extra processes Aug 22 23:56:16 [27826] DBG:core:init_pkg_stats: setting stats for 19 processes Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing mf_process_maxfwd_header, line 279 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 280 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing has_totag, line 284 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing loose_route, line 287 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 288 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x8 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [BYE/8] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 291 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing record_route, line 295 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 309 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x4 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [ACK/4] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 310 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 313 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 321 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 329 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [CANCEL/2] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 331 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 332 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 336 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_from_local, line 341 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing check_source_address, line 344 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing proxy_authorize, line 345 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x817e96c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817e93c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817e9a0 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e9a4)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817e9bc Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [7] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e9a0 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817e9c4 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817e9bc Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817e93c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing proxy_challenge, line 346 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing db_check_from, line 349 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 350 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing consume_credentials, line 354 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing loose_route, line 360 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 362 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 363 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x4 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [ACK/4] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 364 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 369 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x180 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for methods [REGISTER,MESSAGE/384] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing record_route, line 370 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 373 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing append_hf, line 380 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 397 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2200 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for methods [PUBLISH,SUBSCRIBE/8704] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 407 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x80 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [REGISTER/128] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing www_authorize, line 410 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x817e93c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x817e93c inserted in pool as 0x817ec9c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ec6c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817ecd0 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817ecd4)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [7] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817ecd0 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817ecf4 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ec6c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing www_challenge, line 412 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing db_check_to, line 416 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 418 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing save, line 422 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816d188 not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816d188 inserted in pool as 0x817ec9c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817e96c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e970)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817ed64 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [1005] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e96c Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817ed6c Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817ed64 Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817ed64 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817ed68)[0]=[username] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817ed64 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 423 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 430 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing alias_db_lookup, line 435 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_db_load, line 436 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 439 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_print, line 439 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing dp_translate, line 444 Aug 22 23:56:16 [27826] DBG:dialplan:dp_trans_fixup: param_no is 1 Aug 22 23:56:16 [27826] DBG:dialplan:dp_trans_fixup: param_no is 2 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 445 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 448 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 466 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 474 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_branch, line 475 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_reply, line 476 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_failure, line 477 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 480 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 481 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_newtran, line 492 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 494 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 498 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2000 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [PUBLISH/8192] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing handle_publish, line 500 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing lookup, line 526 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_db_query, line 531 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_newtran, line 533 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_reply, line 534 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 540 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 545 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing do_routing, line 557 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 558 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 568 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 576 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 579 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 587 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_was_cancelled, line 590 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing use_next_gw, line 594 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_failure, line 596 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 597 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_reply, line 601 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_status, line 607 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 611 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_status, line 615 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 619 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_was_cancelled, line 622 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 583 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: getsockopt SO_RCVBUF is initially 111616 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 223232 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=223232,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 225280 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=225280,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 227328 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=227328,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 229376 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=229376,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 231424 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=231424,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 233472 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=233472,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 235520 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=235520,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 237568 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=237568,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 239616 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=239616,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 241664 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=241664,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 243712 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=243712,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 245760 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=245760,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 247808 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=247808,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 249856 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=249856,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 251904 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=251904,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 253952 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=253952,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 256000 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=256000,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 258048 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=258048,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 260096 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=260096,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 262144 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=262144,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF has no effect Aug 22 23:56:16 [27826] INFO:core:probe_max_receive_buffer: using a UDP receive buffer of 255 kb Aug 22 23:56:16 [27826] ERROR:core:udp_init: bind(4, 0x816d410, 16) on 192.168.152.148: Cannot assign requested address Aug 22 23:56:16 [27826] DBG:presence_xml:destroy: start Aug 22 23:56:16 [27826] DBG:presence_mwi:destroy: destroying module ... Aug 22 23:56:16 [27826] NOTICE:presence:destroy: destroy module ... Aug 22 23:56:16 [27826] DBG:xlog:destroy: destroy module... Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: tm_shutdown : start Aug 22 23:56:16 [27826] DBG:tm:unlink_timer_lists: emptying DELETE list Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: emptying hash table Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: releasing timers Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: removing semaphores Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: destroying callback lists Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: tm_shutdown : done Aug 22 23:56:16 [27826] DBG:core:shm_mem_destroy: Aug 22 23:56:16 [27826] DBG:core:shm_mem_destroy: destroying the shared memory lock

hi am having so problems with my opensips can you have a look please kind regards

(:nl:)>>messagehead<<

August 23, 2010, at 06:05 AM by olasuleimonhotmailcom - Comment added
Added lines 302-645:

(:nl:)>>messagehead<<

23 August 2010, 06:05

e Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e878)[2]=[mask] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e880)[3]=[port] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e888)[4]=[proto] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e890)[5]=[pattern] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e898)[6]=[context_info] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e8a0)[7]=[id] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query Aug 22 23:56:16 [27826] DBG:permissions:reload_address_table: number of rows in address table: 0 Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:permissions:reload_address_table: address table reloaded successfully. Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for permissions Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module group Aug 22 23:56:16 [27826] DBG:group:mod_init: group module - initializing Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x816d0e4 Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x816cf14)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [3] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x816d164 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x816d15c Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d130 Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:group:mod_init: group database loaded Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module drouting Aug 22 23:56:16 [27826] INFO:drouting:dr_init: Dynamic-Routing - initializing Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:find_cmd_export_t: found <load_tm>(0) in module tm [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for drouting Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module avpops Aug 22 23:56:16 [27826] INFO:avpops:avpops_init: initializing... Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:init_mod: initializing module dialplan Aug 22 23:56:16 [27826] INFO:dialplan:mod_init: initializing module... Aug 22 23:56:16 [27826] DBG:dialplan:mod_init: db_url=mysql://opensips:opensipsrw@localhost/opensips/46/0x8276ca8 Aug 22 23:56:16 [27826] DBG:dialplan:init_data: trying to initialize data from db Aug 22 23:56:16 [27826] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/lib/opensips/modules/] Aug 22 23:56:16 [27826] DBG:core:db_bind_mod: using db bind api for db_mysql Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x816d0e4 Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x816cf14)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x816d188 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [2] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x816cf10 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x816d190 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x816d188 Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:dialplan:dp_load_db: init Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 8 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 128 bytes for result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e868)[0]=[dpid] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e870)[1]=[pr] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e878)[2]=[match_op] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e880)[3]=[match_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e888)[4]=[match_len] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e890)[5]=[subst_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e898)[6]=[repl_exp] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e8a0)[7]=[attrs] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_fetch_result: no rows returned from the query Aug 22 23:56:16 [27826] WARNING:dialplan:dp_load_db: no data in the db Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e848 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x816d15c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:init_mod: register MI for dialplan Aug 22 23:56:16 [27826] DBG:core:count_module_procs: modules require 1 extra processes Aug 22 23:56:16 [27826] DBG:core:init_pkg_stats: setting stats for 19 processes Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing mf_process_maxfwd_header, line 279 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 280 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing has_totag, line 284 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing loose_route, line 287 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 288 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x8 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [BYE/8] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 291 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing record_route, line 295 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 309 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x4 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [ACK/4] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 310 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 313 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 321 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 329 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [CANCEL/2] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 331 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 332 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_trans, line 336 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_from_local, line 341 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing check_source_address, line 344 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing proxy_authorize, line 345 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816cf2c inserted in pool as 0x817e96c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817e93c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817e9a0 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e9a4)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817e9bc Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [7] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e9a0 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817e9c4 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817e9bc Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817e93c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing proxy_challenge, line 346 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing db_check_from, line 349 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 350 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing consume_credentials, line 354 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing loose_route, line 360 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 362 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 363 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x4 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [ACK/4] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 364 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 369 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x180 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for methods [REGISTER,MESSAGE/384] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing record_route, line 370 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 373 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing append_hf, line 380 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 397 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2200 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for methods [PUBLISH,SUBSCRIBE/8704] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 407 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x80 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [REGISTER/128] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing www_authorize, line 410 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x817e93c not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x817e93c inserted in pool as 0x817ec9c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ec6c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817ecd0 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817ecd4)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [7] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817ecd0 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817ecf4 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ec6c Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing www_challenge, line 412 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing db_check_to, line 416 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 418 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing save, line 422 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816d188 not found in pool Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/opensips Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: connection type is Localhost via UNIX socket Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: protocol version is 10 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_connect: server version is 5.0.51a-24+lenny4 Aug 22 23:56:16 [27826] DBG:core:db_do_init: connection 0x816d188 inserted in pool as 0x817ec9c Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817e96c Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817e970)[0]=[table_version] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Aug 22 23:56:16 [27826] DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values at 0x817ed64 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_str2val: converting INT [1005] Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817e96c Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 1 rows Aug 22 23:56:16 [27826] DBG:core:db_free_row: freeing row values at 0x817ed6c Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing rows at 0x817ed64 Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:db_new_result: allocate 28 bytes for result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query Aug 22 23:56:16 [27826] DBG:core:db_allocate_columns: allocate 16 bytes for result columns at 0x817ed64 Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x817ed68)[0]=[username] Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Aug 22 23:56:16 [27826] DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query Aug 22 23:56:16 [27826] DBG:core:db_free_columns: freeing result columns at 0x817ed64 Aug 22 23:56:16 [27826] DBG:core:db_free_rows: freeing 0 rows Aug 22 23:56:16 [27826] DBG:core:db_free_result: freeing result set at 0x817ecec Aug 22 23:56:16 [27826] DBG:core:pool_remove: removing connection from the pool Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 423 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 430 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing alias_db_lookup, line 435 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_db_load, line 436 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 439 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_print, line 439 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing dp_translate, line 444 Aug 22 23:56:16 [27826] DBG:dialplan:dp_trans_fixup: param_no is 1 Aug 22 23:56:16 [27826] DBG:dialplan:dp_trans_fixup: param_no is 2 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 445 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 448 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 466 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 474 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x1 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [INVITE/1] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_branch, line 475 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_reply, line 476 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_failure, line 477 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 480 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 481 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_newtran, line 492 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_reply_error, line 494 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing is_method, line 498 Aug 22 23:56:16 [27826] DBG:core:parse_methods: methods 0x2000 Aug 22 23:56:16 [27826] DBG:textops:fixup_method: using id for method [PUBLISH/8192] Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing handle_publish, line 500 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing lookup, line 526 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing avp_db_query, line 531 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_newtran, line 533 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_reply, line 534 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 540 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing sl_send_reply, line 545 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing do_routing, line 557 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing send_reply, line 558 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 568 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 576 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 579 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 587 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_was_cancelled, line 590 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing use_next_gw, line 594 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_on_failure, line 596 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 597 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_reply, line 601 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_status, line 607 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 611 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_check_status, line 615 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_relay, line 619 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing t_was_cancelled, line 622 Aug 22 23:56:16 [27826] DBG:core:fix_actions: fixing xlog, line 583 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: getsockopt SO_RCVBUF is initially 111616 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 223232 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=223232,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 225280 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=225280,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 227328 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=227328,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 229376 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=229376,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 231424 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=231424,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 233472 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=233472,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 235520 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=235520,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 237568 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=237568,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 239616 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=239616,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 241664 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=241664,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 243712 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=243712,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 245760 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=245760,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 247808 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=247808,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 249856 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=249856,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 251904 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=251904,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 253952 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=253952,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 256000 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=256000,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 258048 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=258048,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 260096 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=260096,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: trying SO_RCVBUF: 262144 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF; set=262144,verify=262142 Aug 22 23:56:16 [27826] DBG:core:probe_max_receive_buffer: setting SO_RCVBUF has no effect Aug 22 23:56:16 [27826] INFO:core:probe_max_receive_buffer: using a UDP receive buffer of 255 kb Aug 22 23:56:16 [27826] ERROR:core:udp_init: bind(4, 0x816d410, 16) on 192.168.152.148: Cannot assign requested address Aug 22 23:56:16 [27826] DBG:presence_xml:destroy: start Aug 22 23:56:16 [27826] DBG:presence_mwi:destroy: destroying module ... Aug 22 23:56:16 [27826] NOTICE:presence:destroy: destroy module ... Aug 22 23:56:16 [27826] DBG:xlog:destroy: destroy module... Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: tm_shutdown : start Aug 22 23:56:16 [27826] DBG:tm:unlink_timer_lists: emptying DELETE list Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: emptying hash table Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: releasing timers Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: removing semaphores Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: destroying callback lists Aug 22 23:56:16 [27826] DBG:tm:tm_shutdown: tm_shutdown : done Aug 22 23:56:16 [27826] DBG:core:shm_mem_destroy: Aug 22 23:56:16 [27826] DBG:core:shm_mem_destroy: destroying the shared memory lock

hi am having so problems with my opensips can you have a look please kind regards

July 25, 2010, at 08:17 PM by Robin - Comment added
Added lines 279-301:

(:nl:)>>messagehead<<

Robin?25 July 2010, 20:17

Hello, I really need some help with getting opensips to start. I checked the user in MySql and in the opensips.cfg file, yet I'm getting the error in the log below. Jul 25 14:12:01 [20481] DBG:textops:fixup_method: using id for method [REGISTER/128] Jul 25 14:12:01 [20481] DBG:core:fix_actions: fixing save, line 329 Jul 25 14:12:01 [20481] DBG:core:db_do_init: connection 0x81a386c not found in pool Jul 25 14:12:01 [20481] DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/1sip2open Jul 25 14:12:01 [20481] ERROR:db_mysql:db_mysql_connect: driver error(1045): Access denied for user 'opensips'@'localhost' (using password: YES) Jul 25 14:12:01 [20481] ERROR:db_mysql:db_mysql_new_connection: initial connect failed Jul 25 14:12:01 [20481] ERROR:core:db_do_init: could not add connection to the pool Jul 25 14:12:01 [20481] ERROR:usrloc:register_udomain: failed to open database connection Jul 25 14:12:01 [20481] ERROR:registrar:domain_fixup: failed to register domain Jul 25 14:12:01 [20481] ERROR:core:fix_actions: fixing failed (code=-1) at cfg line 329 Jul 25 14:12:01 [20481] CRITICAL:core:fix_expr: fix_actions error Jul 25 14:12:01 [20481] ERROR:core:main: failed to fix configuration with err code -1 Jul 25 14:12:01 [20481] DBG:xlog:destroy: destroy module... Jul 25 14:12:01 [20481] DBG:tm:tm_shutdown: tm_shutdown : start

Thanks

April 08, 2010, at 11:55 AM by john pope - Comment added
Added lines 273-278:

(:nl:)>>messagehead<<

john pope08 April 2010, 11:55

set use the username password as opensips /opensipsrw in mysql gui browser

March 24, 2010, at 01:59 PM by bogdan -
Added lines 271-272:

[bogdan] - probably you did not create the "opensips" user and "opensips" group on your system.

March 22, 2010, at 10:58 AM by Vishu - Comment added
Added lines 258-270:

(:nl:)>>messagehead<<

Vishu?22 March 2010, 10:58

Hi

i am getting following error while starting opensips:

debian:/etc/opensips# /etc/init.d/opensips restart chown: invalid user: `opensips:opensips'

Can someone suggest..

March 03, 2010, at 07:36 PM by please - Comment added
Added lines 222-257:

(:nl:)>>messagehead<<

please?03 March 2010, 19:36

HI I got some problem integration with asterisk

I got error when step #opensipsctl fifo domain reload This error is "500 command 'domain' not available".

SO I stop the opensipsctl and start again follow

[root@TEST opensips]# opensipsctl start

INFO: Starting OpenSIPS :

ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

So I check in /var/log/messages and got follow

Mar 4 00:25:05 TEST opensips: ERROR:core:yyparse: module 'uri_db.so' not found in '/lib/opensips/modules/' Mar 4 00:25:05 TEST opensips: CRITICAL:core:yyerror: parse error in config file, line 37, column 13-14: failed to load module Mar 4 00:25:05 TEST opensips: ERROR:core:sr_load_module: could not open module </lib/opensips/modules/>: /lib/opensips/modules/: cannot read file data: Is a directory Mar 4 00:25:05 TEST opensips: CRITICAL:core:yyerror: parse error in config file, line 37, column 13-14: failed to load module Mar 4 00:25:05 TEST opensips: ERROR:core:set_mod_param_regex: no module matching uri_db found Mar 4 00:25:05 TEST opensips: CRITICAL:core:yyerror: parse error in config file, line 63, column 19-20: Parameter <use_uri_table> not found in module <uri_db> - can't set Mar 4 00:25:05 TEST opensips: ERROR:core:set_mod_param_regex: no module matching uri_db found Mar 4 00:25:05 TEST opensips: CRITICAL:core:yyerror: parse error in config file, line 64, column 20-21: Parameter <db_url> not found in module <uri_db> - can't set Mar 4 00:25:05 TEST opensips: ERROR:core:main: bad config file (4 errors)

Can You guys instruction to me?

Thanks Please

February 19, 2010, at 03:24 PM by cicciosbo - Comment added
Added lines 213-221:

(:nl:)>>messagehead<<

cicciosbo?19 February 2010, 15:24

ERROR: Error opening OpenSIPS's FIFO /tmp/opensips_fifo ERROR: Make sure you have the line 'modparam("mi_fifo", "fifo_name", "/tmp/opensips_fifo")' in your config ERROR: and also have loaded the mi_fifo module.

February 18, 2010, at 12:01 PM by bogdan - commet temoved as not related to the page topic
Changed lines 66-67 from:

(:nl:)>>messagehead<<

bogdan23 April 2009, 11:13
to:

(:nl:)>>messagehead<<

nengneng?28 April 2009, 08:22
Deleted lines 68-73:

Hello nengneng - indeed, there is no error reported. Check with ps if OpenSIPs is actually running - if not, increase the debug level to 6 and post the output on the mailing list.

(:nl:)>>messagehead<<

nengneng?28 April 2009, 08:22
Changed line 137 from:

[bogdan] check man page for chkconfig - you need to add a config line in /etc/init.d/opensips script .

to:

[bogdan] - to be able to use the chkconfig, you need to place in the /etc/init.d/opensips file, in the begining, a line line "# chkconfig: 2345 20 80" to indicate the start / stop level - please see the man page for chkconfig.

Changed lines 140-141 from:

(:nl:)>>messagehead<<

bogdan06 August 2009, 15:45
to:

(:nl:)>>messagehead<<

ItMightHep?10 December 2009, 09:25
Deleted lines 143-148:

Lawrence, to be able to use the chkconfig, you need to place in the /etc/init.d/opensips file, in the begining, a line line "# chkconfig: 2345 20 80" to indicate the start / stop level - please see the man page for chkconfig.

(:nl:)>>messagehead<<

ItMightHep?10 December 2009, 09:25
Added lines 202-203:

[bogdan] - see migration docs http://www.opensips.org/Resources/DocsMigration15to16 ; check_to() -> db_check_to()

Changed lines 206-207 from:

(:nl:)>>messagehead<<

Webgeek?23 December 2009, 00:29
to:

(:nl:)>>messagehead<<

Lawrence?07 January 2010, 01:14
Changed lines 210-218 from:

Dec 22 23:27:36 [2289] ERROR:uri:obsolete_fixup_0: You are using one of these obsolete functions: "check_to", "check_from", "does_uri_exist","get_auth_id". They have been renamed with the "db_" prefix.

Dec 22 23:27:36 [2289] ERROR:core:fix_actions: fixing failed (code=-6) at cfg line 257

(:nl:)>>messagehead<<

Lawrence?07 January 2010, 01:14

I keep getting this eror when trying to start open sips, here is all of the log tail, i cant for the life of me find where to chage the parameter.... andy ideas anyone where to begin the search? opensips: ERROR:core:get_script_route_idx: Script route <1> is redefined

to:

I keep getting this eror when trying to start open sips, here is all of the log tail, i cant for the life of me find where to chage the parameter.... andy ideas anyone where to begin the search? opensips: ERROR:core:get_script_route_idx: Script route <1> is redefined

[bogdan] - your script defines twice the route id 1 - look for "route[1]" - it must be only once

February 18, 2010, at 11:53 AM by bogdan - commet temoved as not related to the page topic
Added lines 142-143:

[bogdan] check man page for chkconfig - you need to add a config line in /etc/init.d/opensips script .

February 18, 2010, at 11:51 AM by bogdan - commet temoved as not related to the page topic
Deleted lines 135-141:

(:nl:)>>messagehead<<

1?01 May 2009, 08:49

can not make call to PSTN please help my email:so_sack@yahoo.com

February 18, 2010, at 11:50 AM by bogdan -
Changed lines 29-30 from:

The logs should give you some idea about what went wrong and prevented your OpenSIPS to start. The info from the logs is quite comprehensive to point you the problem.

to:

The logs should give you some idea about what went wrong and prevented your OpenSIPS to start. The info from the logs is quite comprehensive to point you the problem. Even so, it some cases you may consider increasing the verbosity of the logs by setting a higher debug level (debug=4) - it is recommended to do it if you do not see any ERROR message in the first case.

Added lines 62-63:

[bogdan] setting debug level to 4 may give you more hints on what the issue is.

February 18, 2010, at 11:46 AM by bogdan - only comments in english are accepted
Deleted lines 32-38:

(:nl:)>>messagehead<<

aaj?06 April 2009, 10:27

comment installer opensips sur fedora aprés décomprémé

January 07, 2010, at 01:14 AM by Lawrence - Comment added
Added lines 230-235:

(:nl:)>>messagehead<<

Lawrence?07 January 2010, 01:14

I keep getting this eror when trying to start open sips, here is all of the log tail, i cant for the life of me find where to chage the parameter.... andy ideas anyone where to begin the search? opensips: ERROR:core:get_script_route_idx: Script route <1> is redefined

December 23, 2009, at 12:29 AM by Webgeek - Comment added
Added lines 222-229:

(:nl:)>>messagehead<<

Webgeek?23 December 2009, 00:29

Dec 22 23:27:36 [2289] ERROR:uri:obsolete_fixup_0: You are using one of these obsolete functions: "check_to", "check_from", "does_uri_exist","get_auth_id". They have been renamed with the "db_" prefix.

Dec 22 23:27:36 [2289] ERROR:core:fix_actions: fixing failed (code=-6) at cfg line 257

December 23, 2009, at 12:28 AM by Webgeek - Comment added
Added lines 173-221:

(:nl:)>>messagehead<<

Webgeek?23 December 2009, 00:28

I'm getting this error:

opensips:~# opensips restart Dec 22 23:27:36 [2287] WARNING:core:fix_socket_list: could not rev. resolve 192.168.1.60 Dec 22 23:27:36 [2287] WARNING:core:fix_socket_list: could not rev. resolve 192.168.1.60 Listening on

             udp: 127.0.0.1 [127.0.0.1]:5060
             udp: 192.168.1.60 [192.168.1.60]:5060
             tcp: 127.0.0.1 [127.0.0.1]:5060
             tcp: 192.168.1.60 [192.168.1.60]:5060

Aliases:

             tcp: localhost:5060
             udp: localhost:5060

Dec 22 23:27:36 [2287] INFO:core:init_tcp: using epoll_lt as the TCP io watch method (auto detected) Dec 22 23:27:36 [2289] NOTICE:core:main: version: opensips 1.6.0-notls (i386/linux) Dec 22 23:27:36 [2289] INFO:core:main: using 32 Mb shared memory opensips:~# Dec 22 23:27:36 [2289] INFO:core:main: using 1 Mb private memory per process Dec 22 23:27:36 [2289] NOTICE:signaling:mod_init: initializing module ... Dec 22 23:27:36 [2289] INFO:sl:mod_init: Initializing StateLess engine Dec 22 23:27:36 [2289] INFO:tm:mod_init: TM - initializing... Dec 22 23:27:36 [2289] INFO:maxfwd:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:usrloc:ul_init_locks: locks array size 512 Dec 22 23:27:36 [2289] INFO:registrar:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:textops:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:xlog:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:acc:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:auth:mod_init: initializing... Dec 22 23:27:36 [2289] INFO:auth_db:mod_init: initializing... Dec 22 23:27:36 [2289] ERROR:uri:obsolete_fixup_0: You are using one of these obsolete functions: "check_to", "check_from", "does_uri_exist","get_auth_id". They have been renamed with the "db_" prefix. Dec 22 23:27:36 [2289] ERROR:core:fix_actions: fixing failed (code=-6) at cfg line 257 Dec 22 23:27:36 [2289] CRITICAL:core:fix_expr: fix_actions error Dec 22 23:27:36 [2289] ERROR:core:main: failed to fix configuration with err code -6

The main problem seems to be this: Dec 22 23:27:36 [2289] ERROR:uri:obsolete_fixup_0: You are using one of these obsolete functions: "check_to", "check_from", "does_uri_exist","get_auth_id". They have been renamed with the "db_" prefix. Dec 22 23:27:36 [2289] ERROR:core:fix_actions: fixing failed (code=-6) at cfg line 257

I've spent some time lloking for the functions, but can't seem to find it. Thanks Sam

December 10, 2009, at 09:25 AM by ItMightHep - Comment added
Added lines 159-172:

(:nl:)>>messagehead<<

ItMightHep?10 December 2009, 09:25
 opensipsctl start

INFO: Starting OpenSIPS :

ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

This issue is solved by login with user id which is used to install this in my case it is root. i don't have much idea on this but it might help someone.

August 06, 2009, at 03:45 PM by bogdan - Comment added
Added lines 153-158:

(:nl:)>>messagehead<<

bogdan06 August 2009, 15:45

Lawrence, to be able to use the chkconfig, you need to place in the /etc/init.d/opensips file, in the begining, a line line "# chkconfig: 2345 20 80" to indicate the start / stop level - please see the man page for chkconfig.

July 26, 2009, at 09:26 PM by Lawrence - Comment added
Added lines 147-152:

(:nl:)>>messagehead<<

Lawrence?26 July 2009, 21:26

Took me abit of time... have got 99.9 percent complete... i can "service opensips start" the service will start. When 'chkconfig --add opensips' is enter'd i get 'service opensips does not support chkconfig' any ideas... built on centos 5.3

May 01, 2009, at 08:49 AM by 1 - Comment added
Added lines 140-146:

(:nl:)>>messagehead<<

1?01 May 2009, 08:49

can not make call to PSTN please help my email:so_sack@yahoo.com

April 29, 2009, at 04:45 PM by nengneng - Comment added
Added lines 112-138:

(:nl:)>>messagehead<<

nengneng?29 April 2009, 16:45

Hello,there was something wrong when I configurate opensips-cp2.0. In the Makefile,I removed the "mi_xmlrpc" module, then "make all","make install", and maked the following changes in the opensips file configuration /usr/local/etc/opensips/opensips.cfg/: loadmodule "mi_fifo.so" modparam("mi_fifo", "fifo_name", "/tmp/opensips_fifo") modparam("mi_fifo", "fifo_mode", 0600) modparam("mi_fifo", "fifo_group", 0) modparam("mi_fifo", "fifo_group", "root") modparam("mi_fifo", "fifo_user", 0) modparam("mi_fifo", "fifo_user", "root") modparam("mi_fifo", "reply_dir", "/home/opensips/tmp/") modparam("mi_fifo", "reply_indent", " ")

when I ,"/etc/init.d/opensips start",it returned the following output,(I only posted the latter part): Apr 29 22:42:39 [1478] INFO:textops:mod_init: initializing... Apr 29 22:42:39 [1478] DBG:core:init_mod: initializing module mi_fifo Apr 29 22:42:39 [1478] DBG:mi_fifo:mi_mod_init: testing fifo existance ... Apr 29 22:42:39 [1478] ERROR:mi_fifo:mi_mod_init: directory stat failed: No such file or directory Apr 29 22:42:39 [1478] ERROR:core:init_mod: failed to initialize module mi_fifo Apr 29 22:42:39 [1478] ERROR:core:main: error while initializing modules ………………………… Can anybody give me some suggestions.Thank you!

April 28, 2009, at 09:24 AM by nengneng - Comment added
Added lines 101-111:

(:nl:)>>messagehead<<

nengneng?28 April 2009, 09:24

Hello bogdan, I am fixed the matter up now. I checked the opensips.cfg, "modparam("[modulename]", "db_url", "mysql://opensips:opensipsrw@localhost:mysql/opensips"), but in MySQL, the user "opensips" has a password "opensips",I changed the password, and now Opensips is running.

Thank you!

April 28, 2009, at 08:22 AM by nengneng - Comment added
Added lines 74-101:

(:nl:)>>messagehead<<

nengneng?28 April 2009, 08:22

Hello bogdan,I am terribly sorry for sawing your response so late. I truly appreciate your prompt response. I did according to your propsal, and it returned the following output,(I only posted the latter part):

Apr 28 13:42:36 [7334] DBG:db_mysql:db_mysql_new_connection: opening connection: mysql://xxxx:xxxx@localhost/opensips Apr 28 13:42:36 [7334] ERROR:db_mysql:db_mysql_new_connection: driver error(1045): Access denied for user 'opensips'@'localhost' (using password: YES) Apr 28 13:42:36 [7334] ERROR:core:db_do_init: could not add connection to the pool Apr 28 13:42:36 [7334] ERROR:auth_db:auth_fixup: unable to open database connection Apr 28 13:42:36 [7334] ERROR:core:fix_actions: fixing failed (code=-1) at cfg line 328 Apr 28 13:42:36 [7334] CRITICAL:core:fix_expr: fix_actions error Apr 28 13:42:36 [7334] ERROR:core:main: failed to fix configuration with err code -1 Apr 28 13:42:36 [7334] DBG:xlog:destroy: destroy module... Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: tm_shutdown : start Apr 28 13:42:36 [7334] DBG:tm:unlink_timer_lists: emptying DELETE list Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: emptying hash table Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: releasing timers Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: removing semaphores Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: destroying callback lists Apr 28 13:42:36 [7334] DBG:tm:tm_shutdown: tm_shutdown : done Apr 28 13:42:36 [7334] DBG:core:shm_mem_destroy: Apr 28 13:42:36 [7334] DBG:core:shm_mem_destroy: destroying the shared memory lock

Thanks in Advance

April 23, 2009, at 11:13 AM by bogdan - Comment added
Added lines 68-73:

(:nl:)>>messagehead<<

bogdan23 April 2009, 11:13

Hello nengneng - indeed, there is no error reported. Check with ps if OpenSIPs is actually running - if not, increase the debug level to 6 and post the output on the mailing list.

April 22, 2009, at 07:18 AM by nengneng - Comment added
Added lines 39-67:

(:nl:)>>messagehead<<

nengneng?22 April 2009, 07:18

hello, When I

 opensipsctl start

INFO: Starting OpenSIPS :

ERROR: PID file /var/run/opensips.pid does not exist -- OpenSIPS start failed

I looked for the OpenSIPS output: Apr 22 12:10:06 zhuruimin-desktop opensips: INFO:core:init_tcp: using epoll_lt as the TCP io watch method (auto detected) Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: NOTICE:core:main: version: opensips 1.5.0-notls (i386/linux) Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:core:main: using 64 Mb shared memory Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:core:main: using 1 Mb private memory per process Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:sl:mod_init: Initializing StateLess engine Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:tm:mod_init: TM - initializing... Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:maxfwd:mod_init: initializing... Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:usrloc:ul_init_locks: locks array size 512 Apr 22 12:10:06 zhuruimin-desktop /sbin/opensips[7098]: INFO:registrar:mod_init: initializing... Apr 22 12:29:00 zhuruimin-desktop -- MARK -- Apr 22 12:49:00 zhuruimin-desktop -- MARK --

i don't know how to fix it,Can anybody give me some suggestions..

Thanks,

April 06, 2009, at 09:17 PM by bogdan -
Changed line 30 from:

If no still no clue, use the [[Resources.MailingLists | mailing lists] to get help on this - do not forget to post the OpenSIPS logs in your email.

to:

If no still no clue, use the mailing lists to get help on this - do not forget to post the OpenSIPS logs in your email.

April 06, 2009, at 10:27 AM by aaj - Comment added
Added lines 33-39:

(:nl:)>>messagehead<<

aaj?06 April 2009, 10:27

comment installer opensips sur fedora aprés décomprémé

April 05, 2009, at 03:09 PM by bogdan - Removed bogus (test) comment
Deleted lines 32-37:

(:nl:)>>messagehead<<

test?02 April 2009, 20:26

test

April 02, 2009, at 08:26 PM by test - Comment added
Added lines 33-38:

(:nl:)>>messagehead<<

test?02 April 2009, 20:26

test

March 03, 2009, at 10:46 AM by bogdan -
Added lines 32-34:

(:commentboxchrono:)

October 06, 2008, at 12:04 PM by 81.180.102.217 -
Added lines 7-8:

What is the problem?

Added lines 13-31:

Where to look for logs

If you have log_stderror=no in your config file (opensips.cfg), all the logs from OpenSIPS will be sent to the syslog service, so you have the check into the corresponding file, typically:

  1. /var/log/syslog
  2. /var/log/messages

You can simply check system log by:
$ tail -f /var/log/messages

Note you might need root permissions to access these files! If you do not have it, set log_stderror=yes in your config and you will get the log in the console.

If you have log_stderror=yes, you should get the log in the console where you are run OpenSIPS

Reading the error logs

The logs should give you some idea about what went wrong and prevented your OpenSIPS to start. The info from the logs is quite comprehensive to point you the problem. If no still no clue, use the [[Resources.MailingLists | mailing lists] to get help on this - do not forget to post the OpenSIPS logs in your email.

October 06, 2008, at 11:52 AM by 81.180.102.217 -
Added lines 7-10:

More likely you have a configuration error (script error) or a permission error that prevents your OpenSIPS to start.
First of all you have to identify the cause of the error, so look for the OpenSIPS output.

October 06, 2008, at 11:50 AM by 81.180.102.217 -
Changed lines 1-6 from:

vv

to:

Resources -> Documentation -> Doesn't start

Where to check OpenSIPS does not start?

October 06, 2008, at 11:49 AM by 81.180.102.217 -
Added line 1:

vv


Page last modified on April 24, 2013, at 06:37 PM