Hi
I am trying to implement BLF functionality as described in http://kb.asipto.com/kamailio:presence:k43-blf.
I am using the same conf with the one in the tutorial except that i am using postgres database instead of mysql.
The problem is BLF is not working with this config (presence server and proxy server are in the same kamailio with same IP). But when I separate presence server from proxy server (2 different kamilio boxes with different IPs) BLF working perfect. i can see PUBLISH & NOTIFY messages in the tcpdump output with the working configuration. But i can not see any PUBLISH messages in the tcpdump output with the original config (one with presence and proxy servers are same).
My question in the normal working environment (when BLF working perfectly); should i see PUBLISH and NOTIFY messages in the tcpdump output when the presence and proxy servers are the same?
thanks
Huseyin
Hello,
have you captured the traffic on loopback network interface? Try also to run with debug=3 in kamailio.cfg.
Cheers, Daniel
On 10/09/15 22:44, huseyin kalyoncu wrote:
Hi
I am trying to implement BLF functionality as described in http://kb.asipto.com/kamailio:presence:k43-blf.
I am using the same conf with the one in the tutorial except that i am using postgres database instead of mysql.
The problem is BLF is not working with this config (presence server and proxy server are in the same kamailio with same IP). But when I separate presence server from proxy server (2 different kamilio boxes with different IPs) BLF working perfect. i can see PUBLISH & NOTIFY messages in the tcpdump output with the working configuration. But i can not see any PUBLISH messages in the tcpdump output with the original config (one with presence and proxy servers are same).
My question in the normal working environment (when BLF working perfectly); should i see PUBLISH and NOTIFY messages in the tcpdump output when the presence and proxy servers are the same?
thanks
Huseyin
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list sr-users@lists.sip-router.org http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
Hi
After some struggling i solved the problem. It turns out that Kamailio was sending 407 for PUBLISH messages which sent to itself by itself :) and because of that it was not relaying PUBLISH messages. It is a very strange behaviour and hard to recognize without a proper debug output.
I fixed the problem with adding following check to the AUTH route block:
if (is_method("PUBLISH") && src_ip=="MY_IP_ADDRESS") { return; }
After adding this, BLF is working normally with the conf given in the tutorial which was i mentioned in my previous message.
Btw. there is another problem whith BLF when i change db_mode of presence module from 2 to 3. It gives strange duplicate key errors about presentity table and the light remains red constantly after hangup the call. I will try to send those db error messages to this thread later when i have time.
Thanks Huseyin
On Fri, Sep 11, 2015 at 10:04 AM, Daniel-Constantin Mierla < miconda@gmail.com> wrote:
Hello,
have you captured the traffic on loopback network interface? Try also to run with debug=3 in kamailio.cfg.
Cheers, Daniel
On 10/09/15 22:44, huseyin kalyoncu wrote:
Hi
I am trying to implement BLF functionality as described in http://kb.asipto.com/kamailio:presence:k43-blf http://kb.asipto.com/kamailio:presence:k43-blf.
I am using the same conf with the one in the tutorial except that i am using postgres database instead of mysql.
The problem is BLF is not working with this config (presence server and proxy server are in the same kamailio with same IP). But when I separate presence server from proxy server (2 different kamilio boxes with different IPs) BLF working perfect. i can see PUBLISH & NOTIFY messages in the tcpdump output with the working configuration. But i can not see any PUBLISH messages in the tcpdump output with the original config (one with presence and proxy servers are same).
My question in the normal working environment (when BLF working perfectly); should i see PUBLISH and NOTIFY messages in the tcpdump output when the presence and proxy servers are the same?
thanks
Huseyin
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing listsr-users@lists.sip-router.orghttp://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
-- Daniel-Constantin Mierlahttp://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda Book: SIP Routing With Kamailio - http://www.asipto.com Kamailio Advanced Training, Sep 28-30, 2015, in Berlin - http://asipto.com/u/kat
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list sr-users@lists.sip-router.org http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
Hello,
I will adjust the tutorial to make the note about PUBLISH looping back and need to authorize it by IP check.
Regarding "db_mode", are you referring to "subs_db_mode" parameter?
Cheers, Daniel
On 11/09/15 09:17, huseyin kalyoncu wrote:
Hi
After some struggling i solved the problem. It turns out that Kamailio was sending 407 for PUBLISH messages which sent to itself by itself :) and because of that it was not relaying PUBLISH messages. It is a very strange behaviour and hard to recognize without a proper debug output.
I fixed the problem with adding following check to the AUTH route block:
if (is_method("PUBLISH") && src_ip=="MY_IP_ADDRESS") { return; }
After adding this, BLF is working normally with the conf given in the tutorial which was i mentioned in my previous message.
Btw. there is another problem whith BLF when i change db_mode of presence module from 2 to 3. It gives strange duplicate key errors about presentity table and the light remains red constantly after hangup the call. I will try to send those db error messages to this thread later when i have time.
Thanks Huseyin
On Fri, Sep 11, 2015 at 10:04 AM, Daniel-Constantin Mierla <miconda@gmail.com mailto:miconda@gmail.com> wrote:
Hello, have you captured the traffic on loopback network interface? Try also to run with debug=3 in kamailio.cfg. Cheers, Daniel On 10/09/15 22:44, huseyin kalyoncu wrote:
Hi I am trying to implement BLF functionality as described in http://kb.asipto.com/kamailio:presence:k43-blf. I am using the same conf with the one in the tutorial except that i am using postgres database instead of mysql. The problem is BLF is not working with this config (presence server and proxy server are in the same kamailio with same IP). But when I separate presence server from proxy server (2 different kamilio boxes with different IPs) BLF working perfect. i can see PUBLISH & NOTIFY messages in the tcpdump output with the working configuration. But i can not see any PUBLISH messages in the tcpdump output with the original config (one with presence and proxy servers are same). My question in the normal working environment (when BLF working perfectly); should i see PUBLISH and NOTIFY messages in the tcpdump output when the presence and proxy servers are the same? thanks Huseyin _______________________________________________ SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list sr-users@lists.sip-router.org <mailto:sr-users@lists.sip-router.org> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
-- Daniel-Constantin Mierla http://twitter.com/#!/miconda <http://twitter.com/#%21/miconda> - http://www.linkedin.com/in/miconda Book: SIP Routing With Kamailio - http://www.asipto.com Kamailio Advanced Training, Sep 28-30, 2015, in Berlin - http://asipto.com/u/kat _______________________________________________ SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list sr-users@lists.sip-router.org <mailto:sr-users@lists.sip-router.org> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
Hello Daniel
Sorry for the late response. Yes, when i change subs_db_mode to 3 i see lots of error messages as below. 5678*002 is the subscriber for 5678*012 and 5678*011. When all phones idle, everything is fine all lamps are green. But when i make a call i see error messages and nothing changes with the lamps. Sorry for inconvenience but I had to mask public IP addresses in the logs. I am using Kamailio version 4.3.2 and Postgresql-server 9.4.3 as DB. root@km1:~# uname -a Linux km1 3.16.0-4-amd64 #1 SMP Debian 3.16.7-ckt11-1+deb8u3 (2015-08-04) x86_64 GNU/Linux
Btw i tried to separate presence server from proxy but nothing changes and i saw the same errors as below.
Thanks
Huseyin
1:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433545,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*002@XXX.XXX.XX.XXX">#012 <dialog id="1074899713" call-id="1074899713" direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*011@XXX.XXX.XX.XXX</identity>#012 <target uri="sip:5678*011@XXX.XXX.XX.XXX:5060"/>#012 </remote>#012 <local>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX:5060</identity>#012 <target uri="sip:5678*002@XXX.XXX.XX.XXX:5060"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*002' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10032.187.0' Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity Sep 28 11:45:47 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:45:47 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:45:55 km1 kamailio_presence[10035]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:45:55 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:45:55 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:45:55 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:03 km1 kamailio_presence[10031]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:46:03 km1 kamailio_presence[10031]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:03 km1 kamailio_presence[10033]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:46:03 km1 kamailio_presence[10033]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:11 km1 kamailio_presence[10034]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:46:11 km1 kamailio_presence[10034]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:11 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:46:11 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433585,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*012@XXX.XXX.XX.XXX">#012 <dialog id="CLaNCoBMpzbMBIZ6wPvEFw.." call-id="CLaNCoBMpzbMBIZ6wPvEFw.." direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*002@192.168.1.20:63157;transport=tcp;alias=XXX.XXX.XX.XXX~49663~2"/>#012 </remote>#012 <local>#012 <identity>sip:5678*012@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*012@XXX.XXX.XX.XXX;transport=TCP"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*012' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10036.177.0' Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433625,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*012@XXX.XXX.XX.XXX">#012 <dialog id="CLaNCoBMpzbMBIZ6wPvEFw.." call-id="CLaNCoBMpzbMBIZ6wPvEFw.." direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*002@192.168.1.20:63157;transport=tcp;alias=XXX.XXX.XX.XXX~49663~2"/>#012 </remote>#012 <local>#012 <identity>sip:5678*012@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*012@XXX.XXX.XX.XXX;transport=TCP"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*012' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10036.177.0' Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity
On Fri, Sep 11, 2015 at 1:16 PM, Daniel-Constantin Mierla <miconda@gmail.com
wrote:
Hello,
I will adjust the tutorial to make the note about PUBLISH looping back and need to authorize it by IP check.
Regarding "db_mode", are you referring to "subs_db_mode" parameter?
Cheers, Daniel
Hello Daniel,
I have been having some strange crashes after upgrade to 4.3.2
i did not configure for core dump but when i check the kern.log after crash i see this:
Sep 29 22:47:19 km1 kernel: [1815465.204612] kamailio[4211]: segfault at 60 ip 00007f64319df2e4 sp 00007ffe99c703b8 error 4 in libc-2.19.so [7f643194a000+19f000] Sep 29 22:47:19 km1 kernel: [1815465.413074] kamailio[4201]: segfault at f0f0f100 ip 00007f64287c7915 sp 00007ffe99c72600 error 4 in pua_dialoginfo.so[7f64287be000+13000]
On Mon, Sep 28, 2015 at 1:15 PM, huseyin kalyoncu hkalyoncu@gmail.com wrote:
Hello Daniel
Sorry for the late response. Yes, when i change subs_db_mode to 3 i see lots of error messages as below. 5678*002 is the subscriber for 5678*012 and 5678*011. When all phones idle, everything is fine all lamps are green. But when i make a call i see error messages and nothing changes with the lamps. Sorry for inconvenience but I had to mask public IP addresses in the logs. I am using Kamailio version 4.3.2 and Postgresql-server 9.4.3 as DB. root@km1:~# uname -a Linux km1 3.16.0-4-amd64 #1 SMP Debian 3.16.7-ckt11-1+deb8u3 (2015-08-04) x86_64 GNU/Linux
Btw i tried to separate presence server from proxy but nothing changes and i saw the same errors as below.
Thanks
Huseyin
1:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433545,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*002@XXX.XXX.XX.XXX">#012
<dialog id="1074899713" call-id="1074899713" direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*011@XXX.XXX.XX.XXX</identity>#012 <target uri="sip:5678*011@XXX.XXX.XX.XXX:5060"/>#012 </remote>#012 <local>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX:5060</identity>#012 <target uri="sip:5678*002@XXX.XXX.XX.XXX:5060"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*002' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10032.187.0' Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity Sep 28 11:45:47 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:45:47 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:45:55 km1 kamailio_presence[10035]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:45:55 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:45:55 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:45:55 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:03 km1 kamailio_presence[10031]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:46:03 km1 kamailio_presence[10031]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:03 km1 kamailio_presence[10033]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:46:03 km1 kamailio_presence[10033]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:11 km1 kamailio_presence[10034]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:46:11 km1 kamailio_presence[10034]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:11 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:46:11 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433585,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*012@XXX.XXX.XX.XXX">#012 <dialog id="CLaNCoBMpzbMBIZ6wPvEFw.." call-id="CLaNCoBMpzbMBIZ6wPvEFw.." direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*002@192.168.1.20:63157;transport=tcp;alias=XXX.XXX.XX.XXX~49663~2"/>#012 </remote>#012 <local>#012 <identity>sip:5678*012@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*012@XXX.XXX.XX.XXX;transport=TCP"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*012' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10036.177.0' Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433625,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*012@XXX.XXX.XX.XXX">#012 <dialog id="CLaNCoBMpzbMBIZ6wPvEFw.." call-id="CLaNCoBMpzbMBIZ6wPvEFw.." direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*002@192.168.1.20:63157;transport=tcp;alias=XXX.XXX.XX.XXX~49663~2"/>#012 </remote>#012 <local>#012 <identity>sip:5678*012@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*012@XXX.XXX.XX.XXX;transport=TCP"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*012' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10036.177.0' Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity
On Fri, Sep 11, 2015 at 1:16 PM, Daniel-Constantin Mierla < miconda@gmail.com> wrote:
Hello,
I will adjust the tutorial to make the note about PUBLISH looping back and need to authorize it by IP check.
Regarding "db_mode", are you referring to "subs_db_mode" parameter?
Cheers, Daniel
Hello,
are you running the last kamailio branch 4.3 or is from packages?
Do you get a core dump file? If yes, can you send the backtrace?
Daniel
On 29/09/15 23:07, huseyin kalyoncu wrote:
Hello Daniel,
I have been having some strange crashes after upgrade to 4.3.2
i did not configure for core dump but when i check the kern.log after crash i see this:
Sep 29 22:47:19 km1 kernel: [1815465.204612] kamailio[4211]: segfault at 60 ip 00007f64319df2e4 sp 00007ffe99c703b8 error 4 in libc-2.19.so http://libc-2.19.so[7f643194a000+19f000] Sep 29 22:47:19 km1 kernel: [1815465.413074] kamailio[4201]: segfault at f0f0f100 ip 00007f64287c7915 sp 00007ffe99c72600 error 4 in pua_dialoginfo.so[7f64287be000+13000]
On Mon, Sep 28, 2015 at 1:15 PM, huseyin kalyoncu <hkalyoncu@gmail.com mailto:hkalyoncu@gmail.com> wrote:
Hello Daniel Sorry for the late response. Yes, when i change subs_db_mode to 3 i see lots of error messages as below. 5678*002 is the subscriber for 5678*012 and 5678*011. When all phones idle, everything is fine all lamps are green. But when i make a call i see error messages and nothing changes with the lamps. Sorry for inconvenience but I had to mask public IP addresses in the logs. I am using Kamailio version 4.3.2 and Postgresql-server 9.4.3 as DB. root@km1:~# uname -a Linux km1 3.16.0-4-amd64 #1 SMP Debian 3.16.7-ckt11-1+deb8u3 (2015-08-04) x86_64 GNU/Linux Btw i tried to separate presence server from proxy but nothing changes and i saw the same errors as below. Thanks Huseyin 1:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433545,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*002@XXX.XXX.XX.XXX">#012 <dialog id="1074899713" call-id="1074899713" direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*011@XXX.XXX.XX.XXX</identity>#012 <target uri="sip:5678*011@XXX.XXX.XX.XXX:5060"/>#012 </remote>#012 <local>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX:5060</identity>#012 <target uri="sip:5678*002@XXX.XXX.XX.XXX:5060"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*002' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10032.187.0' Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity Sep 28 11:45:47 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:45:47 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:45:55 km1 kamailio_presence[10035]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:45:55 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:45:55 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:45:55 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:03 km1 kamailio_presence[10031]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:46:03 km1 kamailio_presence[10031]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:03 km1 kamailio_presence[10033]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:46:03 km1 kamailio_presence[10033]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:11 km1 kamailio_presence[10034]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:46:11 km1 kamailio_presence[10034]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:11 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:46:11 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433585,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*012@XXX.XXX.XX.XXX">#012 <dialog id="CLaNCoBMpzbMBIZ6wPvEFw.." call-id="CLaNCoBMpzbMBIZ6wPvEFw.." direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*002@192.168.1.20:63157;transport=tcp;alias=XXX.XXX.XX.XXX~49663~2"/>#012 </remote>#012 <local>#012 <identity>sip:5678*012@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*012@XXX.XXX.XX.XXX;transport=TCP"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*012' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10036.177.0' Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433625,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*012@XXX.XXX.XX.XXX">#012 <dialog id="CLaNCoBMpzbMBIZ6wPvEFw.." call-id="CLaNCoBMpzbMBIZ6wPvEFw.." direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*002@192.168.1.20:63157;transport=tcp;alias=XXX.XXX.XX.XXX~49663~2"/>#012 </remote>#012 <local>#012 <identity>sip:5678*012@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*012@XXX.XXX.XX.XXX;transport=TCP"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*012' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10036.177.0' Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity On Fri, Sep 11, 2015 at 1:16 PM, Daniel-Constantin Mierla <miconda@gmail.com <mailto:miconda@gmail.com>> wrote: Hello, I will adjust the tutorial to make the note about PUBLISH looping back and need to authorize it by IP check. Regarding "db_mode", are you referring to "subs_db_mode" parameter? Cheers, Daniel
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list sr-users@lists.sip-router.org http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
Hello Daniel
Thank you for your response. Kamailio from 4.3.2 source tarball I got the core file now. After running backtrace i realized that the problem might be related to our custom module we are developing. Here is the backtrace:
Reading symbols from /usr/local/sbin/kamailio...done. [New LWP 6985] [Thread debugging using libthread_db enabled] Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1". Core was generated by `/usr/local/sbin/kamailio -f /usr/local/etc/kamailio/kamailio.cfg -P /var/run/ka'. Program terminated with signal SIGSEGV, Segmentation fault. #0 __strcpy_sse2_unaligned () at ../sysdeps/x86_64/multiarch/strcpy-sse2-unaligned.S:63 63 ../sysdeps/x86_64/multiarch/strcpy-sse2-unaligned.S: No such file or directory. (gdb) backtrace #0 __strcpy_sse2_unaligned () at ../sysdeps/x86_64/multiarch/strcpy-sse2-unaligned.S:63 #1 0x00007f9aa1f08b09 in vg_digest_authenticate_hdr (msg=0x7f9aaae4eca8, realm=0x7ffe4af97700, hftype=HDR_PROXYAUTH_T, method=0x7f9aaae4ecd0, ahdr=0x7ffe4af976f8) at auth.c:75 #2 0x00007f9aa1f08da8 in w_vg_auth (pmsg=0x7f9aaae4eca8) at auth.c:230 #3 0x0000000000444a19 in do_action (h=0x7ffe4af97da0, a=0x7f9aaadaf628, msg=0x7f9aaae4eca8) at action.c:1053 #4 0x0000000000450a29 in run_actions (h=0x7ffe4af97da0, a=0x7f9aaadaf628, msg=0x7f9aaae4eca8) at action.c:1548 #5 0x0000000000451067 in run_actions_safe (h=0x7ffe4af99480, a=0x7f9aaadaf628, msg=0x7f9aaae4eca8) at action.c:1613 #6 0x000000000041da42 in rval_get_int (h=0x7ffe4af99480, msg=0x7f9aaae4eca8, i=0x7ffe4af98148, rv=0x7f9aaadaf750, cache=0x0) at rvalue.c:912 #7 0x0000000000421bf7 in rval_expr_eval_int (h=0x7ffe4af99480, msg=0x7f9aaae4eca8, res=0x7ffe4af98148, rve=0x7f9aaadaf748) at rvalue.c:1906 #8 0x0000000000421fc6 in rval_expr_eval_int (h=0x7ffe4af99480, msg=0x7f9aaae4eca8, res=0x7ffe4af98580, rve=0x7f9aaadafe48) at rvalue.c:1914 #9 0x0000000000444563 in do_action (h=0x7ffe4af99480, a=0x7f9aaadb10b0, msg=0x7f9aaae4eca8) at action.c:1029 #10 0x0000000000450a29 in run_actions (h=0x7ffe4af99480, a=0x7f9aaadb10b0, msg=0x7f9aaae4eca8) at action.c:1548 #11 0x0000000000444988 in do_action (h=0x7ffe4af99480, a=0x7f9aaadb2010, msg=0x7f9aaae4eca8) at action.c:1044 #12 0x0000000000450a29 in run_actions (h=0x7ffe4af99480, a=0x7f9aaadab968, msg=0x7f9aaae4eca8) at action.c:1548 #13 0x0000000000441770 in do_action (h=0x7ffe4af99480, a=0x7f9aaad68448, msg=0x7f9aaae4eca8) at action.c:677 #14 0x0000000000450a29 in run_actions (h=0x7ffe4af99480, a=0x7f9aaad68098, msg=0x7f9aaae4eca8) at action.c:1548 #15 0x000000000045112f in run_top_route (a=0x7f9aaad68098, msg=0x7f9aaae4eca8, c=0x0) at action.c:1634 #16 0x000000000056ffb4 in receive_msg (buf=0x7f9a9e14ff50 "PUBLISH sip:5678*0002@XXX.XXX.XX.XXX;transport=TCP SIP/2.0\r\nVia: SIP/2.0/TCP 192.168.1.20:41329;branch=z9hG4bK-524287-1---f71b84e56e32cb58\r\nMax-Forwards: 69\r\nContact: <sip:5678*0002@192.168.1.20:41329"..., len=1243, rcv_info=0x7f9a9e14fc78) at receive.c:196 #17 0x00000000005f389c in receive_tcp_msg (tcpbuf=0x7f9a9e14ff50 "PUBLISH sip:5678*0002@XXX.XXX.XX.XXX;transport=TCP SIP/2.0\r\nVia: SIP/2.0/TCP 192.168.1.20:41329;branch=z9hG4bK-524287-1---f71b84e56e32cb58\r\nMax-Forwards: 69\r\nContact: <sip:5678*0002@192.168.1.20:41329"..., len=1243, rcv_info=0x7f9a9e14fc78, con=0x7f9a9e14fc60) at tcp_read.c:1200 #18 0x00000000005f5389 in tcp_read_req (con=0x7f9a9e14fc60, bytes_read=0x7ffe4af9986c, read_flags=0x7ffe4af99868) at tcp_read.c:1401 #19 0x00000000005f78ff in handle_io (fm=0x7f9aaae3a9a8, events=1, idx=-1) at tcp_read.c:1568 #20 0x00000000005ec052 in io_wait_loop_epoll (h=0xa35940 <io_w>, t=2, repeat=0) at io_wait.h:1061 #21 0x00000000005f920b in tcp_receive_loop (unix_sock=74) at tcp_read.c:1733 #22 0x00000000004cc0c5 in tcp_init_children () at tcp_main.c:4787 #23 0x0000000000503f01 in main_loop () at main.c:1658 #24 0x00000000005097f7 in main (argc=9, argv=0x7ffe4af99d98) at main.c:2533
On Wed, Sep 30, 2015 at 9:51 AM, Daniel-Constantin Mierla <miconda@gmail.com
wrote:
Hello,
are you running the last kamailio branch 4.3 or is from packages?
Do you get a core dump file? If yes, can you send the backtrace?
Daniel
On 29/09/15 23:07, huseyin kalyoncu wrote:
Hello Daniel,
I have been having some strange crashes after upgrade to 4.3.2
i did not configure for core dump but when i check the kern.log after crash i see this:
Sep 29 22:47:19 km1 kernel: [1815465.204612] kamailio[4211]: segfault at 60 ip 00007f64319df2e4 sp 00007ffe99c703b8 error 4 in libc-2.19.so [7f643194a000+19f000] Sep 29 22:47:19 km1 kernel: [1815465.413074] kamailio[4201]: segfault at f0f0f100 ip 00007f64287c7915 sp 00007ffe99c72600 error 4 in pua_dialoginfo.so[7f64287be000+13000]
On Mon, Sep 28, 2015 at 1:15 PM, huseyin kalyoncu < hkalyoncu@gmail.com hkalyoncu@gmail.com> wrote:
Hello Daniel
Sorry for the late response. Yes, when i change subs_db_mode to 3 i see lots of error messages as below. 5678*002 is the subscriber for 5678*012 and 5678*011. When all phones idle, everything is fine all lamps are green. But when i make a call i see error messages and nothing changes with the lamps. Sorry for inconvenience but I had to mask public IP addresses in the logs. I am using Kamailio version 4.3.2 and Postgresql-server 9.4.3 as DB. root@km1:~# uname -a Linux km1 3.16.0-4-amd64 #1 SMP Debian 3.16.7-ckt11-1+deb8u3 (2015-08-04) x86_64 GNU/Linux
Btw i tried to separate presence server from proxy but nothing changes and i saw the same errors as below.
Thanks
Huseyin
1:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433545,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*002@XXX.XXX.XX.XXX">#012
<dialog id="1074899713" call-id="1074899713" direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity> sip:5678*011@XXX.XXX.XX.XXX</identity>#012 <target uri= "sip:5678*011@XXX.XXX.XX.XXX:5060"/>#012 </remote>#012 <local>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX:5060</identity>#012 <target uri="sip:5678*002@XXX.XXX.XX.XXX:5060"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*002' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10032.187.0' Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*002, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:45:45 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:45:45 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity Sep 28 11:45:47 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:45:47 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:45:55 km1 kamailio_presence[10035]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:45:55 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:45:55 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:45:55 km1 kamailio_presence[10036]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:03 km1 kamailio_presence[10031]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:46:03 km1 kamailio_presence[10031]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:03 km1 kamailio_presence[10033]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:46:03 km1 kamailio_presence[10033]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:11 km1 kamailio_presence[10034]: ERROR: presence [subscribe.c:1617]: get_database_info(): wrong sequence number received: 22 - stored: 22 Sep 28 11:46:11 km1 kamailio_presence[10034]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:11 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:1601]: get_database_info(): No matching subscription dialog found in database Sep 28 11:46:11 km1 kamailio_presence[10035]: INFO: presence [subscribe.c:949]: handle_subscribe(): getting stored info Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433585,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*012@XXX.XXX.XX.XXX">#012 <dialog id="CLaNCoBMpzbMBIZ6wPvEFw.." call-id="CLaNCoBMpzbMBIZ6wPvEFw.." direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri= "sip:5678*002@192.168.1.20:63157;transport=tcp;alias=XXX.XXX.XX.XXX~49663~2"/>#012 </remote>#012 <local>#012 <identity> sip:5678*012@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*012@XXX.XXX.XX.XXX;transport=TCP"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*012' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10036.177.0' Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:46:25 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:46:25 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:277]: db_postgres_submit_query(): postgres result check failed with code 7 (PGRES_FATAL_ERROR) Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:281]: db_postgres_submit_query(): postgres query command failed, connection status 0, error [ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012] Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:290]: db_postgres_submit_query(): 0x7f0dd4497060 PQsendQuery Error: ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists.#012 Query: update presentity set etag='*#-OFFLINE-#*',expires=1443433625,body='<?xml version="1.0"?>#012<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="00000000000" state="full" entity="sip:5678*012@XXX.XXX.XX.XXX">#012 <dialog id="CLaNCoBMpzbMBIZ6wPvEFw.." call-id="CLaNCoBMpzbMBIZ6wPvEFw.." direction="recipient">#012 <state>terminated</state>#012 <remote>#012 <identity>sip:5678*002@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri= "sip:5678*002@192.168.1.20:63157;transport=tcp;alias=XXX.XXX.XX.XXX~49663~2"/>#012 </remote>#012 <local>#012 <identity> sip:5678*012@XXX.XXX.XX.XXX;transport=TCP</identity>#012 <target uri="sip:5678*012@XXX.XXX.XX.XXX;transport=TCP"/>#012 </local>#012 </dialog>#012</dialog-info>#012' where username='5678*012' AND domain='XXX.XXX.XX.XXX' AND event='dialog' AND etag='a.1442821424.10036.177.0' Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: <core> [db_query.c:339]: db_do_update(): error while submitting query Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:580]: db_postgres_store_result(): invalid query, execution aborted Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: db_postgres [km_dbase.c:581]: db_postgres_store_result(): driver error: PGRES_FATAL_ERROR, ERROR: duplicate key value violates unique constraint "presentity_presentity_idx"#012DETAIL: Key (username, domain, event, etag)=(5678*012, XXX.XXX.XX.XXX, dialog, *#-OFFLINE-#*) already exists. Sep 28 11:47:05 km1 kamailio_presence[10037]: WARNING: db_postgres [km_dbase.c:690]: db_postgres_update(): unexpected result returned Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: presence [presentity.c:1324]: mark_presentity_for_delete(): unsuccessful sql update operation Sep 28 11:47:05 km1 kamailio_presence[10037]: ERROR: presence [publish.c:169]: msg_presentity_clean(): Marking presentity
On Fri, Sep 11, 2015 at 1:16 PM, Daniel-Constantin Mierla < miconda@gmail.com> wrote:
Hello,
I will adjust the tutorial to make the note about PUBLISH looping back and need to authorize it by IP check.
Regarding "db_mode", are you referring to "subs_db_mode" parameter?
Cheers, Daniel
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing listsr-users@lists.sip-router.orghttp://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
-- Daniel-Constantin Mierlahttp://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda Book: SIP Routing With Kamailio - http://www.asipto.com Kamailio Advanced Training, Sep 28-30, 2015, in Berlin - http://asipto.com/u/kat
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list sr-users@lists.sip-router.org http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
Hello Daniel,
I have an update for the errors with duplicate key messages.
5678*0012 calls 5678*0002 and 5678*0007 is the subscriber for both. When the call starts i see this:
kamailio=# select username, etag from presentity; username | etag -----------+------------------------ 5678*0012 | a.1443699235.22541.5.0 5678*0002 | a.1443699235.22551.3.0 5678*0012 | a.1443699235.22549.5.0 5678*0002 | a.1443699235.22551.4.0 5678*0012 | a.1443699235.22542.4.0 5678*0002 | a.1443699235.22546.5.0 5678*0012 | a.1443699235.22548.6.0 (7 rows)
After call answered Kmailio tries to update all 5678*0012 records with etag='*#-OFFLINE-#*'. Since there are more than 1 record for 5678*0012 then it gives the "duplicate key value violates unique constraint" errors. But i couldnt understand why Kamailio tries to set 5678*0012 as offline in the first place? Both devices registered and lamp states on 5678*0007 are green when idle.
Btw if the call is long lamp states turn green again before call ends. And there is nothing left on table
kamailio=# select username, etag from presentity; username | etag ----------+------ (0 rows)
Lamps should remain red until call ends, right?
Thanks
Huseyin
Hello,
On 30/09/15 09:37, huseyin kalyoncu wrote:
Hello Daniel
Thank you for your response. Kamailio from 4.3.2 source tarball I got the core file now. After running backtrace i realized that the problem might be related to our custom module we are developing. Here is the backtrace:
Reading symbols from /usr/local/sbin/kamailio...done. [New LWP 6985] [Thread debugging using libthread_db enabled] Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1". Core was generated by `/usr/local/sbin/kamailio -f /usr/local/etc/kamailio/kamailio.cfg -P /var/run/ka'. Program terminated with signal SIGSEGV, Segmentation fault. #0 __strcpy_sse2_unaligned () at ../sysdeps/x86_64/multiarch/strcpy-sse2-unaligned.S:63 63 ../sysdeps/x86_64/multiarch/strcpy-sse2-unaligned.S: No such file or directory. (gdb) backtrace #0 __strcpy_sse2_unaligned () at ../sysdeps/x86_64/multiarch/strcpy-sse2-unaligned.S:63 #1 0x00007f9aa1f08b09 in vg_digest_authenticate_hdr (msg=0x7f9aaae4eca8, realm=0x7ffe4af97700, hftype=HDR_PROXYAUTH_T, method=0x7f9aaae4ecd0, ahdr=0x7ffe4af976f8) at auth.c:75 #2 0x00007f9aa1f08da8 in w_vg_auth (pmsg=0x7f9aaae4eca8) at auth.c:230
the backtrace shows some functions that don't exist in public kamailio repository (e.g., w_vg_auth()).
I assume you wrote some custom module, the backtrace indicates that the crash is in that code.
Cheers, Daniel