Resources.DocsTsStart History

Hide minor edits - Show changes to output

April 24, 2013, at 07:37 PM by 213.233.101.41 -
Changed lines 1-787 from:
!!Resources -> [[Resources.Documentation | Documentation]] -> Doesn't start

>>red<<
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:
# /var/log/syslog
# /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 [[Resources.MailingLists | mailing lists]] to get help on this - do not forget to post the '''OpenSIPS''' logs in your email.



[[#comment2]](:nl:)>>messagehead<<
!!!!![[~nengneng]] &mdash; [-22 April 2009, 07:18-]
>>messageitem<<
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,

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

[[#comment4]](:nl:)>>messagehead<<
!!!!![[~nengneng]] &mdash; [-28 April 2009, 08:22-]
>>messageitem<<
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

>><<

[[#comment5]](:nl:)>>messagehead<<
!!!!![[~nengneng]] &mdash; [-28 April 2009, 09:24-]
>>messageitem<<
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!

>><<

[[#comment6]](:nl:)>>messagehead<<
!!!!![[~nengneng]] &mdash; [-29 April 2009, 16:45-]
>>messageitem<<
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!

>><<

[[#comment8]](:nl:)>>messagehead<<
!!!!![[~Lawrence]] &mdash; [-26 July 2009, 21:26-]
>>messageitem<<
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

%blue%[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.%%
>><<


[[#comment10]](:nl:)>>messagehead<<
!!!!![[~ItMightHep]] &mdash; [-10 December 2009, 09:25-]
>>messageitem<<
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.
>><<

[[#comment11]](:nl:)>>messagehead<<
!!!!![[~Webgeek]] &mdash; [-23 December 2009, 00:28-]
>>messageitem<<
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

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


[[#comment13]](:nl:)>>messagehead<<
!!!!![[~Lawrence]] &mdash; [-07 January 2010, 01:14-]
>>messageitem<<
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 &lt;1&gt; is redefined

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

[[#comment9]](:nl:)>>messagehead<<
!!!!![[~cicciosbo]] &mdash; [-19 February 2010, 15:24-]
>>messageitem<<
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.

>><<

[[#comment10]](:nl:)>>messagehead<<
!!!!![[~please]] &mdash; [-03 March 2010, 19:36-]
>>messageitem<<
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 &lt;/lib/opensips/modules/&gt;: /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 &lt;use_uri_table&gt; not found in module &lt;uri_db&gt; - 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 &lt;db_url&gt; not found in module &lt;uri_db&gt; - 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
>><<

[[#comment11]](:nl:)>>messagehead<<
!!!!![[~Vishu]] &mdash; [-22 March 2010, 10:58-]
>>messageitem<<
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..

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

[[#comment12]](:nl:)>>messagehead<<
!!!!![[~john pope]] &mdash; [-08 April 2010, 11:55-]
>>messageitem<<
set use the username password as opensips /opensipsrw in mysql gui browser
>><<

[[#comment13]](:nl:)>>messagehead<<
!!!!![[~Robin]] &mdash; [-25 July 2010, 20:17-]
>>messageitem<<
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


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


[[#comment16]](:nl:)>>messagehead<<
!!!!![[~Chrispy]] &mdash; [-01 September 2010, 01:46-]
>>messageitem<<
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

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

[[#comment17]](:nl:)>>messagehead<<
!!!!![[~jm21]] &mdash; [-20 September 2010, 22:22-]
>>messageitem<<
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?

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

[[#comment16]](:nl:)>>messagehead<<
!!!!![[~sipsip]] &mdash; [-13 January 2011, 11:13-]
>>messageitem<<
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 ??

%blue%[bogdan] - use "adduser" and "addgroup" system commands %%
>><<

[[#comment17]](:nl:)>>messagehead<<
!!!!![[~sipsip]] &mdash; [-13 January 2011, 11:24-]
>>messageitem<<
this is my /etc/default/opesips
#
# OpenSIPS startup options
#

# Set to yes to enable opensips, once configured properly.
RUN_OPENSIPS=yes

# User to run as
USER=opensips

# Group to run as
GROUP=opensips

# Amount of memory to allocate for the running OpenSIPS server (in Mb)
MEMORY=128

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


so, where is the problem??
>><<

[[#comment18]](:nl:)>>messagehead<<
!!!!![[~Mahmut Cahmut]] &mdash; [-28 January 2011, 10:55-]
>>messageitem<<
dhcppc:~# opensipsctl start

INFO: Starting OpenSIPS :

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

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

[[#comment19]](:nl:)>>messagehead<<
!!!!![[~Naser ]] &mdash; [-22 February 2011, 19:41-]
>>messageitem<<
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,


>><<

[[#comment20]](:nl:)>>messagehead<<
!!!!![[~Bhavik Pandya]] &mdash; [-11 April 2011, 22:12-]
>>messageitem<<
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...

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

[[#comment21]](:nl:)>>messagehead<<
!!!!![[~lisongchao]] &mdash; [-21 May 2011, 10:30-]
>>messageitem<<
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???

%blue%[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" %%
>><<

[[#comment22]](:nl:)>>messagehead<<
!!!!![[~sipsip]] &mdash; [-07 July 2011, 12:28-]
>>messageitem<<
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 ?

>><<

[[#comment23]](:nl:)>>messagehead<<
!!!!![[~prabb]] &mdash; [-02 August 2011, 23:53-]
>>messageitem<<
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.
>><<

[[#comment24]](:nl:)>>messagehead<<
!!!!![[~prabb]] &mdash; [-03 August 2011, 20:21-]
>>messageitem<<
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:
# Set to yes to enable opensips, once configured properly.
RUN_OPENSIPS=yes

# User to run as
USER=opensips

# 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


# 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:
# If you want to setup a database with opensipsdbctl, you must at least specify
# this parameter.
DBENGINE=MYSQL

## database host
DBHOST=localhost

## database name (for ORACLE this is TNS name)
DBNAME=opensips

# database path used by dbtext or db_berkeley
#DB_PATH="/usr/local/etc/opensips/dbtext"

## database read/write user
DBRWUSER=opensips

## password for database read/write user
DBRWPW="password"

## database super user (for ORACLE this is 'scheme-creator' user)
DBROOTUSER="root"

# 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.


>><<

[[#comment25]](:nl:)>>messagehead<<
!!!!![[~manish]] &mdash; [-11 August 2011, 20:30-]
>>messageitem<<
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

>><<

[[#comment26]](:nl:)>>messagehead<<
!!!!![[~manish]] &mdash; [-11 August 2011, 20:37-]
>>messageitem<<
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
>><<


[[#comment29]](:nl:)>>messagehead<<
!!!!![[~Rico]] &mdash; [-20 October 2011, 14:57-]
>>messageitem<<

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.
>><<


[[#comment28]](:nl:)>>messagehead<<
!!!!![[~Scott]] &mdash; [-29 December 2011, 00:06-]
>>messageitem<<
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 -&gt; nothing to kill


thanks

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

[[#comment29]](:nl:)>>messagehead<<
!!!!![[~Tasos]] &mdash; [-15 February 2012, 16:06-]
>>messageitem<<
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
>><<

[[#comment30]](:nl:)>>messagehead<<
!!!!![[~Tasos]] &mdash; [-15 February 2012, 16:15-]
>>messageitem<<
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!
>><<

[[#comment31]](:nl:)>>messagehead<<
!!!!![[~H-Anh]] &mdash; [-31 March 2012, 18:36-]
>>messageitem<<
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
>><<

[[#comment32]](:nl:)>>messagehead<<
!!!!![[~casey]] &mdash; [-17 April 2012, 18:35-]
>>messageitem<<
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
>><<

[[#comment33]](:nl:)>>messagehead<<
!!!!![[~Rick]] &mdash; [-21 May 2012, 08:13-]
>>messageitem<<
Hi All,

I also received the same error --&gt; 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
>><<

[[#comment34]](:nl:)>>messagehead<<
!!!!![[~Kumar]] &mdash; [-30 October 2012, 15:02-]
>>messageitem<<
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?

>><<

[[#comment35]](:nl:)>>messagehead<<
!!!!![[~Alvin]] &mdash; [-07 March 2013, 05:56-]
>>messageitem<<
ERROR:db_mysql:mysql_raise_event: event not registered -1
>><<

[[#comment36]](:nl:)>>messagehead<<
!!!!![[~amrindhe]] &mdash; [-20 March 2013, 23:16-]
>>messageitem<<
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!

>><<

[[#comment37]](:nl:)>>messagehead<<
!!!!![[~sakalaboator]] &mdash; [-22 March 2013, 06:33-]
>>messageitem<<
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 07:33 AM by 218.206.107.242 - Comment added
Added lines 778-784:
>><<

[[#comment37]](:nl:)>>messagehead<<
!!!!![[~sakalaboator]] &mdash; [-22 March 2013, 06:33-]
>>messageitem<<
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 21, 2013, at 12:16 AM by amrindhe - Comment added
Added lines 764-777:
>><<

[[#comment36]](:nl:)>>messagehead<<
!!!!![[~amrindhe]] &mdash; [-20 March 2013, 23:16-]
>>messageitem<<
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 06:56 AM by Alvin - Comment added
Added lines 758-763:
>><<

[[#comment35]](:nl:)>>messagehead<<
!!!!![[~Alvin]] &mdash; [-07 March 2013, 05:56-]
>>messageitem<<
ERROR:db_mysql:mysql_raise_event: event not registered -1
October 30, 2012, at 04:02 PM by Kumar - Comment added
Added lines 745-757:
>><<

[[#comment34]](:nl:)>>messagehead<<
!!!!![[~Kumar]] &mdash; [-30 October 2012, 15:02-]
>>messageitem<<
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 11:06 AM by bogdan -
Deleted lines 744-749:
>><<

[[#comment34]](:nl:)>>messagehead<<
!!!!![[~Laxmikant]] &mdash; [-24 October 2012, 11:06-]
>>messageitem<<
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 12:06 PM by Laxmikant - Comment added
Added lines 745-750:
>><<

[[#comment34]](:nl:)>>messagehead<<
!!!!![[~Laxmikant]] &mdash; [-24 October 2012, 11:06-]
>>messageitem<<
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 02:15 PM by bogdan -
Deleted lines 744-755:
>><<

[[#comment34]](:nl:)>>messagehead<<
!!!!![[~Orvito]] &mdash; [-22 October 2012, 05:44-]
>>messageitem<<
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.
>><<

[[#comment35]](:nl:)>>messagehead<<
!!!!![[~Victor]] &mdash; [-22 October 2012, 05:56-]
>>messageitem<<
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 06:56 AM by Victor - Comment added
Added lines 751-756:
>><<

[[#comment35]](:nl:)>>messagehead<<
!!!!![[~Victor]] &mdash; [-22 October 2012, 05:56-]
>>messageitem<<
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 06:44 AM by Orvito - Comment added
Added lines 745-750:
>><<

[[#comment34]](:nl:)>>messagehead<<
!!!!![[~Orvito]] &mdash; [-22 October 2012, 05:44-]
>>messageitem<<
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 09:13 AM by Rick - Comment added
Added lines 731-742:

Thanks
>><<

[[#comment33]](:nl:)>>messagehead<<
!!!!![[~Rick]] &mdash; [-21 May 2012, 08:13-]
>>messageitem<<
Hi All,

I also received the same error --&gt; 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 07:35 PM by casey - Comment added
Added lines 720-730:

Thanks
>><<

[[#comment32]](:nl:)>>messagehead<<
!!!!![[~casey]] &mdash; [-17 April 2012, 18:35-]
>>messageitem<<
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 07:36 PM by H-Anh - Comment added
Added lines 699-721:
>><<

[[#comment31]](:nl:)>>messagehead<<
!!!!![[~H-Anh]] &mdash; [-31 March 2012, 18:36-]
>>messageitem<<
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 05:15 PM by soulatsos - Comment added
Added lines 689-698:
>><<

[[#comment30]](:nl:)>>messagehead<<
!!!!![[~Tasos]] &mdash; [-15 February 2012, 16:15-]
>>messageitem<<
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 05:06 PM by Tasos - Comment added
Added lines 675-688:
>><<

[[#comment29]](:nl:)>>messagehead<<
!!!!![[~Tasos]] &mdash; [-15 February 2012, 16:06-]
>>messageitem<<
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 06:12 PM by bogdan -
Added lines 673-674:

%blue%[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 01:06 AM by Scott - Comment added
Added lines 651-673:

[[#comment28]](:nl:)>>messagehead<<
!!!!![[~Scott]] &mdash; [-29 December 2011, 00:06-]
>>messageitem<<
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 -&gt; nothing to kill


thanks
>><<
October 27, 2011, at 05:37 PM by bogdan -
Deleted lines 650-654:
[[#comment28]](:nl:)>>messagehead<<
!!!!![[~Keli]] &mdash; [-26 October 2011, 18:05-]
>>messageitem<<
Whoa, whoa, get out the way with that good ifnromation.
>><<
October 26, 2011, at 07:05 PM by Keli - Comment added
Added lines 649-654:
>><<

[[#comment28]](:nl:)>>messagehead<<
!!!!![[~Keli]] &mdash; [-26 October 2011, 18:05-]
>>messageitem<<
Whoa, whoa, get out the way with that good ifnromation.
October 21, 2011, at 11:02 AM by bogdan -
Changed lines 636-637 from:
[[#comment27]](:nl:)>>messagehead<<
!!!!![[~Rico]] &mdash; [-20 October 2011, 14:56-]
to:

[[#comment29]](:nl:)>>messagehead<<
!!!!![[~Rico]] &mdash; [-20 October 2011, 14:57-]
Deleted lines 639-855:
# 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 &lt;db_url&gt; 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 &lt;use_domain&gt; 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 &lt;probing_interval&gt; 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 &lt;probing_from&gt; 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 &lt;probing_method&gt; 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 &lt;probing_reply_codes&gt; 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 &lt;fifo_name&gt; 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 &lt;append_fromtag&gt; 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 &lt;db_mode&gt; 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 &lt;early_media&gt; 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 &lt;report_cancels&gt; 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 &lt;detect_direction&gt; 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 &lt;failed_transaction_flag&gt; 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 &lt;log_flag&gt; 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 &lt;log_missed_flag&gt; 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 &lt;db_flag&gt; 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 &lt;db_missed_flag&gt; in module acc [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;mf_process_maxfwd_header&gt;(1) in module maxfwd [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;has_totag&gt;(0) in module uri [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;loose_route&gt;(0) in module rr [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;record_route&gt;(0) in module rr [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_check_trans&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_relay&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_check_trans&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_relay&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_check_trans&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;loose_route&gt;(0) in module rr [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;record_route&gt;(0) in module rr [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;append_hf&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;save&gt;(1) in module registrar [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_reply_error&gt;(0) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;lookup&gt;(2) in module registrar [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_newtran&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_reply&gt;(2) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_on_branch&gt;(1) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_on_reply&gt;(1) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_on_failure&gt;(1) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_relay&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_reply_error&gt;(0) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_was_cancelled&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;do_routing&gt;(1) in module drouting [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;send_reply&gt;(2) in module signaling [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_on_failure&gt;(1) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_was_cancelled&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_check_status&gt;(1) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;use_next_gw&gt;(0) in module drouting [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_relay&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_reply&gt;(2) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:socket2str: &lt;udp:126.16.108.220:5060&gt;
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 &lt;E_CORE_THRESHOLD(0)&gt;
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 &lt;load_tm&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;load_sl&gt;(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 &lt;load_sig&gt;(1) in module signaling [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;load_tm&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;ul_bind_usrloc&gt;(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 &lt;db_bind_api&gt; 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

>><<

[[#comment28]](:nl:)>>messagehead<<
!!!!![[~Rico]] &mdash; [-20 October 2011, 14:57-]
>>messageitem<<
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.
>><<

[[#comment29]](:nl:)>>messagehead<<
!!!!![[~Rico]] &mdash; [-20 October 2011, 14:57-]
>>messageitem<<
Sorry for last message :
October 20, 2011, at 03:57 PM by Rico - Comment added
Added lines 838-852:
!!!!![[~Rico]] &mdash; [-20 October 2011, 14:57-]
>>messageitem<<
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.
>><<

[[#comment29]](:nl:)>>messagehead<<
October 20, 2011, at 03:57 PM by Rico - Comment added
Added lines 835-849:
>><<

[[#comment28]](:nl:)>>messagehead<<
!!!!![[~Rico]] &mdash; [-20 October 2011, 14:57-]
>>messageitem<<
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 03:56 PM by Rico - Comment added
Added lines 634-834:
>><<

[[#comment27]](:nl:)>>messagehead<<
!!!!![[~Rico]] &mdash; [-20 October 2011, 14:56-]
>>messageitem<<
# 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 &lt;db_url&gt; 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 &lt;use_domain&gt; 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 &lt;probing_interval&gt; 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 &lt;probing_from&gt; 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 &lt;probing_method&gt; 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 &lt;probing_reply_codes&gt; 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 &lt;fifo_name&gt; 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 &lt;append_fromtag&gt; 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 &lt;db_mode&gt; 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 &lt;early_media&gt; 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 &lt;report_cancels&gt; 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 &lt;detect_direction&gt; 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 &lt;failed_transaction_flag&gt; 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 &lt;log_flag&gt; 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 &lt;log_missed_flag&gt; 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 &lt;db_flag&gt; 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 &lt;db_missed_flag&gt; in module acc [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;mf_process_maxfwd_header&gt;(1) in module maxfwd [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;has_totag&gt;(0) in module uri [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;loose_route&gt;(0) in module rr [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;record_route&gt;(0) in module rr [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_check_trans&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_relay&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_check_trans&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_relay&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_check_trans&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;loose_route&gt;(0) in module rr [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;record_route&gt;(0) in module rr [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;append_hf&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;save&gt;(1) in module registrar [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_reply_error&gt;(0) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;lookup&gt;(2) in module registrar [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_newtran&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_reply&gt;(2) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_send_reply&gt;(2) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_on_branch&gt;(1) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_on_reply&gt;(1) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_on_failure&gt;(1) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_relay&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;sl_reply_error&gt;(0) in module sl [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_was_cancelled&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;do_routing&gt;(1) in module drouting [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;send_reply&gt;(2) in module signaling [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;is_method&gt;(1) in module textops [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_on_failure&gt;(1) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_was_cancelled&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_check_status&gt;(1) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;use_next_gw&gt;(0) in module drouting [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_relay&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;t_reply&gt;(2) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:socket2str: &lt;udp:126.16.108.220:5060&gt;
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 &lt;E_CORE_THRESHOLD(0)&gt;
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 &lt;load_tm&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;load_sl&gt;(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 &lt;load_sig&gt;(1) in module signaling [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;load_tm&gt;(0) in module tm [/usr/local/lib/opensips/modules/]
Oct 20 14:54:49 opensips opensips: DBG:core:find_cmd_export_t: found &lt;ul_bind_usrloc&gt;(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 &lt;db_bind_api&gt; 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 09:37 PM by manish - Comment added
Added lines 596-633:
>><<

[[#comment26]](:nl:)>>messagehead<<
!!!!![[~manish]] &mdash; [-11 August 2011, 20:37-]
>>messageitem<<
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 09:30 PM by manish - Comment added
Added lines 565-594:

>><<

[[#comment25]](:nl:)>>messagehead<<
!!!!![[~manish]] &mdash; [-11 August 2011, 20:30-]
>>messageitem<<
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 09:21 PM by prabb - Comment added
Added lines 479-565:
>><<

[[#comment24]](:nl:)>>messagehead<<
!!!!![[~prabb]] &mdash; [-03 August 2011, 20:21-]
>>messageitem<<
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:
# Set to yes to enable opensips, once configured properly.
RUN_OPENSIPS=yes

# User to run as
USER=opensips

# 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


# 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:
# If you want to setup a database with opensipsdbctl, you must at least specify
# this parameter.
DBENGINE=MYSQL

## database host
DBHOST=localhost

## database name (for ORACLE this is TNS name)
DBNAME=opensips

# database path used by dbtext or db_berkeley
#DB_PATH="/usr/local/etc/opensips/dbtext"

## database read/write user
DBRWUSER=opensips

## password for database read/write user
DBRWPW="password"

## database super user (for ORACLE this is 'scheme-creator' user)
DBROOTUSER="root"

# 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 03, 2011, at 12:53 AM by prabb - Comment added
Added lines 473-478:
>><<

[[#comment23]](:nl:)>>messagehead<<
!!!!![[~prabb]] &mdash; [-02 August 2011, 23:53-]
>>messageitem<<
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 01:28 PM by sipsip - Comment added
Added lines 457-472:
>><<

[[#comment22]](:nl:)>>messagehead<<
!!!!![[~sipsip]] &mdash; [-07 July 2011, 12:28-]
>>messageitem<<
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 06:04 PM by 109.99.2.142 -
Deleted lines 456-461:
>><<

[[#comment22]](:nl:)>>messagehead<<
!!!!![[~Caden]] &mdash; [-27 June 2011, 02:04-]
>>messageitem<<
I thank you humbly for sharing your wiosdm JJWY
June 27, 2011, at 03:04 AM by Caden - Comment added
Added lines 457-462:
>><<

[[#comment22]](:nl:)>>messagehead<<
!!!!![[~Caden]] &mdash; [-27 June 2011, 02:04-]
>>messageitem<<
I thank you humbly for sharing your wiosdm JJWY
May 23, 2011, at 11:30 AM by bogdan -
Added lines 455-456:

%blue%[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 11:30 AM by lisongchao - Comment added
Added lines 441-454:
>><<

[[#comment21]](:nl:)>>messagehead<<
!!!!![[~lisongchao]] &mdash; [-21 May 2011, 10:30-]
>>messageitem<<
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 02:13 PM by bogdan -
Added lines 360-361:

%blue%[bogdan] - use "adduser" and "addgroup" system commands %%
Added lines 406-407:

%blue%[bogdan] - check the log files (see the page content) for opensips errors - most probably your opensips fails to start. %%
Added lines 439-440:

%blue%[bogdan] - check the log files (see the page content) for opensips errors - most probably your opensips fails to start. %%
April 11, 2011, at 11:12 PM by Bhavik Pandya - Comment added
Added lines 412-434:
>><<

[[#comment20]](:nl:)>>messagehead<<
!!!!![[~Bhavik Pandya]] &mdash; [-11 April 2011, 22:12-]
>>messageitem<<
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 08:41 PM by Naser - Comment added
Added lines 404-411:
>><<

[[#comment19]](:nl:)>>messagehead<<
!!!!![[~Naser ]] &mdash; [-22 February 2011, 19:41-]
>>messageitem<<
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 11:55 AM by Mahmut Cahmut - Comment added
Added lines 393-403:
>><<

[[#comment18]](:nl:)>>messagehead<<
!!!!![[~Mahmut Cahmut]] &mdash; [-28 January 2011, 10:55-]
>>messageitem<<
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 12:24 PM by sipsip - Comment added
Added lines 360-392:
>><<

[[#comment17]](:nl:)>>messagehead<<
!!!!![[~sipsip]] &mdash; [-13 January 2011, 11:24-]
>>messageitem<<
this is my /etc/default/opesips
#
# OpenSIPS startup options
#

# Set to yes to enable opensips, once configured properly.
RUN_OPENSIPS=yes

# User to run as
USER=opensips

# Group to run as
GROUP=opensips

# Amount of memory to allocate for the running OpenSIPS server (in Mb)
MEMORY=128

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


so, where is the problem??
January 13, 2011, at 12:13 PM by sipsip - Comment added
Added lines 349-359:
>><<

[[#comment16]](:nl:)>>messagehead<<
!!!!![[~sipsip]] &mdash; [-13 January 2011, 11:13-]
>>messageitem<<
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 10:09 AM by bogdan -
Added lines 302-304:


%blue%[bogdan] - in opensips cfg, the db_url for usrloc module is not correctly set.%%
Changed lines 307-308 from:
[[#comment14]](:nl:)>>messagehead<<
!!!!![[~olasuleimon@hotmail.com]] &mdash; [-23 August 2010, 06:05-]
to:

[[#comment16]](:nl:)>>messagehead<<
!!!!![[~Chrispy]] &mdash; [-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 &lt;db_bind_api&gt; 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 &lt;db_bind_api&gt; 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 &lt;load_tm&gt;(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 &lt;db_bind_api&gt; 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 &lt;db_bind_api&gt; 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

%blue%[bogdan] - do you start opensips with -p param to point to a PD file ?%%
Changed lines 323-324 from:
[[#comment15]](:nl:)>>messagehead<<
!!!!![[~olasuleimon@hotmail.com]] &mdash; [-23 August 2010, 06:05-]
to:
[[#comment17]](:nl:)>>messagehead<<
!!!!![[~jm21]] &mdash; [-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 &lt;db_bind_api&gt; 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 &lt;db_bind_api&gt; 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 &lt;load_tm&gt;(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 &lt;db_bind_api&gt; 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 &lt;db_bind_api&gt; 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
>><<

[[#comment16]](:nl:)>>messagehead<<
!!!!![[~Chrispy]] &mdash; [-01 September 2010, 01:46-]
>>messageitem<<
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
>><<

[[#comment17]](:nl:)>>messagehead<<
!!!!![[~jm21]] &mdash; [-20 September 2010, 22:22-]
>>messageitem<<
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:
%blue%[bogdan] - signal 2 is SIGINT - looks like your opensips is terminated by other app. %%
September 20, 2010, at 11:22 PM by jm21 - Comment added
Added lines 1003-1030:
>><<

[[#comment17]](:nl:)>>messagehead<<
!!!!![[~jm21]] &mdash; [-20 September 2010, 22:22-]
>>messageitem<<
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 02:46 AM by Chrispy - Comment added
Added lines 990-1002:
>><<

[[#comment16]](:nl:)>>messagehead<<
!!!!![[~Chrispy]] &mdash; [-01 September 2010, 01:46-]
>>messageitem<<
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 07:05 AM by olasuleimonhotmailcom - Comment added
Added lines 305-648:
!!!!![[~olasuleimon@hotmail.com]] &mdash; [-23 August 2010, 06:05-]
>>messageitem<<
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 &lt;db_bind_api&gt; 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 &lt;db_bind_api&gt; 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 &lt;load_tm&gt;(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 &lt;db_bind_api&gt; 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 &lt;db_bind_api&gt; 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
>><<

[[#comment15]](:nl:)>>messagehead<<
August 23, 2010, at 07:05 AM by olasuleimonhotmailcom - Comment added
Added lines 302-645:
>><<

[[#comment14]](:nl:)>>messagehead<<
!!!!![[~olasuleimon@hotmail.com]] &mdash; [-23 August 2010, 06:05-]
>>messageitem<<
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 &lt;db_bind_api&gt; 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 &lt;db_bind_api&gt; 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 &lt;load_tm&gt;(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 &lt;db_bind_api&gt; 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 &lt;db_bind_api&gt; 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 09:17 PM by Robin - Comment added
Added lines 279-301:
>><<

[[#comment13]](:nl:)>>messagehead<<
!!!!![[~Robin]] &mdash; [-25 July 2010, 20:17-]
>>messageitem<<
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 12:55 PM by john pope - Comment added
Added lines 273-278:
>><<

[[#comment12]](:nl:)>>messagehead<<
!!!!![[~john pope]] &mdash; [-08 April 2010, 11:55-]
>>messageitem<<
set use the username password as opensips /opensipsrw in mysql gui browser
March 24, 2010, at 02:59 PM by bogdan -
Added lines 271-272:

%blue%[bogdan] - probably you did not create the "opensips" user and "opensips" group on your system.%%
March 22, 2010, at 11:58 AM by Vishu - Comment added
Added lines 258-270:
>><<

[[#comment11]](:nl:)>>messagehead<<
!!!!![[~Vishu]] &mdash; [-22 March 2010, 10:58-]
>>messageitem<<
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 08:36 PM by please - Comment added
Added lines 222-257:
>><<

[[#comment10]](:nl:)>>messagehead<<
!!!!![[~please]] &mdash; [-03 March 2010, 19:36-]
>>messageitem<<
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 &lt;/lib/opensips/modules/&gt;: /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 &lt;use_uri_table&gt; not found in module &lt;uri_db&gt; - 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 &lt;db_url&gt; not found in module &lt;uri_db&gt; - 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 04:24 PM by cicciosbo - Comment added
Added lines 213-221:
>><<

[[#comment9]](:nl:)>>messagehead<<
!!!!![[~cicciosbo]] &mdash; [-19 February 2010, 15:24-]
>>messageitem<<
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 01:01 PM by bogdan - commet temoved as not related to the page topic
Changed lines 66-67 from:
[[#comment3]](:nl:)>>messagehead<<
!!!!![[~bogdan]] &mdash; [-23 April 2009, 11:13-]
to:
[[#comment4]](:nl:)>>messagehead<<
!!!!![[~nengneng]] &mdash; [-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.
>><<

[[#comment4]](:nl:)>>messagehead<<
!!!!![[~nengneng]] &mdash; [-28 April 2009, 08:22-]
>>messageitem<<
Changed line 137 from:
%blue%[bogdan] check man page for chkconfig - you need to add a config line in /etc/init.d/opensips script .%%
to:
%blue%[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:
[[#comment9]](:nl:)>>messagehead<<
!!!!![[~bogdan]] &mdash; [-06 August 2009, 15:45-]
to:

[[#comment10]](:nl:)>>messagehead<<
!!!!![[~ItMightHep]] &mdash; [-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.
>><<

[[#comment10]](:nl:)>>messagehead<<
!!!!![[~ItMightHep]] &mdash; [-10 December 2009, 09:25-]
>>messageitem<<
Added lines 202-203:

%blue%[bogdan] - see migration docs http://www.opensips.org/Resources/DocsMigration15to16 ; check_to() -> db_check_to()%%
Changed lines 206-207 from:
[[#comment12]](:nl:)>>messagehead<<
!!!!![[~Webgeek]] &mdash; [-23 December 2009, 00:29-]
to:

[[#comment13]](:nl:)>>messagehead<<
!!!!![[~Lawrence]] &mdash; [-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
>><<

[[#comment13]](:nl:)>>messagehead<<
!!!!![[~Lawrence]] &mdash; [-07 January 2010, 01:14-]
>>messageitem<<
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 &lt;1&gt; 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 &lt;1&gt; is redefined

%blue%[bogdan] - your script defines twice the route id 1 - look for "route[1]" - it must be only once%%
February 18, 2010, at 12:53 PM by bogdan - commet temoved as not related to the page topic
Added lines 142-143:

%blue%[bogdan] check man page for chkconfig - you need to add a config line in /etc/init.d/opensips script .%%
February 18, 2010, at 12:51 PM by bogdan - commet temoved as not related to the page topic
Deleted lines 135-141:
>><<

[[#comment7]](:nl:)>>messagehead<<
!!!!![[~1]] &mdash; [-01 May 2009, 08:49-]
>>messageitem<<
can not make call to PSTN please help
my email:so_sack@yahoo.com
February 18, 2010, at 12:50 PM 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:

%blue%[bogdan] setting debug level to 4 may give you more hints on what the issue is.%%
February 18, 2010, at 12:46 PM by bogdan - only comments in english are accepted
Deleted lines 32-38:

[[#comment1]](:nl:)>>messagehead<<
!!!!![[~aaj]] &mdash; [-06 April 2009, 10:27-]
>>messageitem<<
comment installer opensips sur fedora aprés décomprémé

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

[[#comment13]](:nl:)>>messagehead<<
!!!!![[~Lawrence]] &mdash; [-07 January 2010, 01:14-]
>>messageitem<<
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 &lt;1&gt; is redefined
December 23, 2009, at 01:29 AM by Webgeek - Comment added
Added lines 222-229:
>><<

[[#comment12]](:nl:)>>messagehead<<
!!!!![[~Webgeek]] &mdash; [-23 December 2009, 00:29-]
>>messageitem<<
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 01:28 AM by Webgeek - Comment added
Added lines 173-221:
>><<

[[#comment11]](:nl:)>>messagehead<<
!!!!![[~Webgeek]] &mdash; [-23 December 2009, 00:28-]
>>messageitem<<
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 10:25 AM by ItMightHep - Comment added
Added lines 159-172:
>><<

[[#comment10]](:nl:)>>messagehead<<
!!!!![[~ItMightHep]] &mdash; [-10 December 2009, 09:25-]
>>messageitem<<
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 04:45 PM by bogdan - Comment added
Added lines 153-158:
>><<

[[#comment9]](:nl:)>>messagehead<<
!!!!![[~bogdan]] &mdash; [-06 August 2009, 15:45-]
>>messageitem<<
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 10:26 PM by Lawrence - Comment added
Added lines 147-152:
>><<

[[#comment8]](:nl:)>>messagehead<<
!!!!![[~Lawrence]] &mdash; [-26 July 2009, 21:26-]
>>messageitem<<
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 09:49 AM by 1 - Comment added
Added lines 140-146:
>><<

[[#comment7]](:nl:)>>messagehead<<
!!!!![[~1]] &mdash; [-01 May 2009, 08:49-]
>>messageitem<<
can not make call to PSTN please help
my email:so_sack@yahoo.com
April 29, 2009, at 05:45 PM by nengneng - Comment added
Added lines 112-138:

>><<

[[#comment6]](:nl:)>>messagehead<<
!!!!![[~nengneng]] &mdash; [-29 April 2009, 16:45-]
>>messageitem<<
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 10:24 AM by nengneng - Comment added
Added lines 101-111:

>><<

[[#comment5]](:nl:)>>messagehead<<
!!!!![[~nengneng]] &mdash; [-28 April 2009, 09:24-]
>>messageitem<<
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 09:22 AM by nengneng - Comment added
Added lines 74-101:
>><<

[[#comment4]](:nl:)>>messagehead<<
!!!!![[~nengneng]] &mdash; [-28 April 2009, 08:22-]
>>messageitem<<
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 12:13 PM by bogdan - Comment added
Added lines 68-73:
>><<

[[#comment3]](:nl:)>>messagehead<<
!!!!![[~bogdan]] &mdash; [-23 April 2009, 11:13-]
>>messageitem<<
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 08:18 AM by nengneng - Comment added
Added lines 39-67:
>><<

[[#comment2]](:nl:)>>messagehead<<
!!!!![[~nengneng]] &mdash; [-22 April 2009, 07:18-]
>>messageitem<<
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 10: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 [[Resources.MailingLists | mailing lists]] to get help on this - do not forget to post the '''OpenSIPS''' logs in your email.
April 06, 2009, at 11:27 AM by aaj - Comment added
Added lines 33-39:

[[#comment1]](:nl:)>>messagehead<<
!!!!![[~aaj]] &mdash; [-06 April 2009, 10:27-]
>>messageitem<<
comment installer opensips sur fedora aprés décomprémé

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

[[#comment1]](:nl:)>>messagehead<<
!!!!![[~test]] &mdash; [-02 April 2009, 20:26-]
>>messageitem<<
test
>><<
April 02, 2009, at 09:26 PM by test - Comment added
Added lines 33-38:

[[#comment1]](:nl:)>>messagehead<<
!!!!![[~test]] &mdash; [-02 April 2009, 20:26-]
>>messageitem<<
test
>><<
March 03, 2009, at 11:46 AM by bogdan -
Added lines 32-34:


(:commentboxchrono:)
October 06, 2008, at 01: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:
# /var/log/syslog
# /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 12:52 PM 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 12:50 PM by 81.180.102.217 -
Changed lines 1-6 from:
vv
to:
!!Resources -> [[Resources.Documentation | Documentation]] -> Doesn't start

>>red<<
Where to check '''OpenSIPS''' does not start?
>><<
October 06, 2008, at 12:49 PM by 81.180.102.217 -
Added line 1:
vv

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