[OpenSIPS-Users] Opensips not storing dialog information in dbtext

Bogdan-Andrei Iancu bogdan at opensips.org
Fri Sep 23 09:55:15 CEST 2016 

Hi Husnain,

The db_text driver is flushing to file only at shutdown or upon dbt_dump 
MI command. Otherwise, the data is cached in memory.

Best regards,

Bogdan-Andrei Iancu
OpenSIPS Founder and Developer
http://www.opensips-solutions.com

On 22.09.2016 20:50, Husnain Taseer wrote:
> Dear Users,
> I am using opensips 2.2.1 on debian server. dialog table is configured 
> with dbtext to store information, but there is no information 
> populated by opensips in dialog file. I have tried almost all the 
> combination of db_mode for dialog and dbtext module but no luck. My 
> current configuration for dbtext and dialog module is:
>
>
> loadmodule "db_text.so"
> modparam("db_text", "db_mode",1)
>
> loadmodule "dialog.so"
> modparam("dialog", "db_mode", 1)
> modparam("dialog", "dlg_match_mode", 1)
> modparam("dialog", "default_timeout", 3600)
> modparam("dialog", "profiles_with_value", "caller ; callee")
> modparam("dialog", "profiles_no_value", "inbound ; outbound")
> modparam("dialog", "db_update_period", 10)
> modparam("dialog", "db_url", 
> "text:///usr/local/v2Term/etc/opensips/dbtext")
>
> When I make call I can see that dialog has been created which can be 
> shown using "dlg_list"
> /
> /
> /dialog::  hash=1396:1435064472/
> /        state:: 4/
> /        user_flags:: 0/
> /        timestart:: 1474564499/
> /        datestart:: 2016-09-22 13:14:59/
> /        timeout:: 1474571700/
> /        dateout:: 2016-09-22 15:15:00/
> /        callid:: MDkxZTdlZjRiN2ZkNzQ0NzcxZjU4N2U4NTZmNTZmYzc./
> /        from_uri:: sip:1404xxxxx at xx.xx.xx.xx/
> /        to_uri:: sip:8977xxxxx at xx.xx.xx.xx/
> /        caller_tag:: 2d682d42/
> /        caller_contact:: sip:1404xxxxxx at xx.xx.xx:38756/
> /        callee_cseq:: 0/
> /        caller_route_set::/
> /        caller_bind_addr:: udp:xx.xx.xx.xx:5060 
> <http://216.55.177.129:5060>/
> /        caller_sdp::/
> /        CALLEES::/
> /                callee::/
> /                        callee_tag:: 15830SIPpTag0110/
> /                        callee_contact:: 
> sip:8977xxxxxx at xx.xx.xx.xx:5067;transport=UDP/
> /                        caller_cseq:: 1/
> /                        callee_route_set::/
> /                        callee_bind_addr:: udp:xx.xx.xx.xx:5060 
> <http://216.55.177.129:5060>/
> /                        callee_sdp::/
>
> But during this ongoing session there isn't any thing in the dialog 
> file except heading and also the last change time of that file is of 
> yesterday when it was created. Here are the debug logs related to 
> dialog when call comes on opensips.
>
>
> /Sep 22 13:14:59 localhost ./opensips[6258]: 
> DBG:dialog:w_create_dialog2: bye on timeout activated/
> /Sep 22 13:14:59 localhost ./opensips[6258]: DBG:dialog:build_new_dlg: 
> new dialog 0x7ff790731ab0 
> (c=MDkxZTdlZjRiN2ZkNzQ0NzcxZjU4N2U4NTZmNTZmYzc.,f=sip:1404xxxxx at xx.xx.xx.xx,t=sip:8977xxxxx at xx.xx.xx.xx,ft=2d682d42) 
> on hash 1396/
> /Sep 22 13:14:59 localhost ./opensips[6258]: DBG:dialog:init_leg_info: 
> route_set , contact sip:1404xxxxx at xx.xx.xx.xx:38756, cseq 1 and 
> bind_addr udp:xx.xx.xx.xx:5060/
> /Sep 22 13:14:59 localhost ./opensips[6258]: 
> DBG:dialog:dlg_add_leg_info: set leg 0 for 0x7ff790731ab0: 
> tag=<2d682d42> rcseq=<0>/
> /Sep 22 13:14:59 localhost ./opensips[6258]: DBG:dialog:link_dlg: ref 
> dlg 0x7ff790731ab0 with 3 -> 3 in h_entry 0x7ff7906f1280 - 1396/
> /Sep 22 13:14:59 localhost ./opensips[6258]: 
> DBG:dialog:link_dlg_profile: Entered here with hash = 10/
> /Sep 22 13:14:59 localhost ./opensips[6258]: DBG:dialog:dlg_onreq: t 
> hash_index = 17835, t label = 1923053288/
> /Sep 22 13:14:59 localhost ./opensips[6258]: DBG:dialog:unref_dlg: 
> unref dlg 0x7ff790731ab0 with 1 -> 2 in entry 0x7ff7906f1280/
> /Sep 22 13:14:59 localhost ./opensips[6257]: 
> DBG:dialog:push_reply_in_dialog: 0x7ff790731ab0 totag in rpl is 
> <15830SIPpTag0110> (16)/
> /Sep 22 13:14:59 localhost ./opensips[6257]: 
> DBG:dialog:push_reply_in_dialog: new branch with tag <15830SIPpTag0110>/
> /Sep 22 13:14:59 localhost ./opensips[6257]: DBG:dialog:init_leg_info: 
> route_set , contact , cseq 1 and bind_addr udp:xx.xx.xx.xx:5060/
> /Sep 22 13:14:59 localhost ./opensips[6257]: 
> DBG:dialog:dlg_add_leg_info: set leg 1 for 0x7ff790731ab0: 
> tag=<15830SIPpTag0110> rcseq=<1>/
> /Sep 22 13:14:59 localhost ./opensips[6257]: 
> DBG:dialog:push_reply_in_dialog: Skipping 1 ,0, 0, 1/
> /Sep 22 13:14:59 localhost ./opensips[6257]: 
> DBG:dialog:dlg_update_routing: dialog 0x7ff790731ab0[1]: rr=<> 
> contact=<sip:8977xxxx at xx.xx.xx.xx:5067;transport=UDP>/
> /Sep 22 13:14:59 localhost ./opensips[6257]: 
> DBG:dialog:next_state_dlg: dialog 0x7ff790731ab0 changed from state 1 
> to state 3, due event 3/
> /Sep 22 13:14:59 localhost ./opensips[6257]: DBG:dialog:dlg_onreply: 
> dialog 0x7ff790731ab0 confirmed/
> /Sep 22 13:14:59 localhost ./opensips[6257]: 
> DBG:dialog:insert_dlg_timer_unsafe: inserting 0x7ff790731af8 for 7883/
> /Sep 22 13:14:59 localhost ./opensips[6257]: DBG:dialog:ref_dlg: ref 
> dlg 0x7ff790731ab0 with 1 -> 3/
> /Sep 22 13:14:59 localhost ./opensips[6257]: 
> DBG:dialog:set_final_update_cols: DLG vals and profiles should not be 
> saved[11b:0]/
> /Sep 22 13:14:59 localhost ./opensips[6257]: 
> DBG:db_text:dbt_db_get_table: cache or mtime succeeded for [dialog]/
> /Sep 22 13:14:59 localhost ./opensips[6257]: 
> DBG:dialog:run_dlg_callbacks: dialog=0x7ff790731ab0, type=8/
> /Sep 22 13:15:00 localhost ./opensips[6257]: 
> DBG:dialog:push_reply_in_dialog: 0x7ff790731ab0 totag in rpl is 
> <15830SIPpTag0110> (16)/
> /Sep 22 13:15:00 localhost ./opensips[6257]: 
> DBG:dialog:push_reply_in_dialog: branch with tag <15830SIPpTag0110> 
> already exists/
> /Sep 22 13:15:00 localhost ./opensips[6263]: DBG:dialog:dlg_onroute: 
> route param is '475.89859855' (len=12)/
> /Sep 22 13:15:00 localhost ./opensips[6263]: DBG:dialog:lookup_dlg: 
> ref dlg 0x7ff790731ab0 with 1 -> 4/
> /Sep 22 13:15:00 localhost ./opensips[6263]: DBG:dialog:lookup_dlg: 
> dialog id=1435064472 found on entry 1396/
> /Sep 22 13:15:00 localhost ./opensips[6263]: 
> DBG:dialog:next_state_dlg: dialog 0x7ff790731ab0 changed from state 3 
> to state 4, due event 6/
> /Sep 22 13:15:00 localhost ./opensips[6263]: DBG:dialog:dlg_onroute: 
> sequential request successfully processed (dst_leg=1)/
> /Sep 22 13:15:00 localhost ./opensips[6263]: DBG:dialog:dlg_onroute: 
> dialog_timeout: 7200/
> /Sep 22 13:15:00 localhost ./opensips[6263]: 
> DBG:dialog:set_final_update_cols: DLG vals and profiles should not be 
> saved[1a:0]/
> /Sep 22 13:15:00 localhost ./opensips[6263]: 
> DBG:dialog:write_dialog_profiles: profile string is 
> <caller#xx.xx.xx.xx|>(20)/
> /Sep 22 13:15:00 localhost ./opensips[6263]: 
> DBG:db_text:dbt_db_get_table: cache or mtime succeeded for [dialog]/
> /Sep 22 13:15:00 localhost ./opensips[6263]: DBG:dialog:unref_dlg: 
> unref dlg 0x7ff790731ab0 with 1 -> 3 in entry 0x7ff7906f1280/
> /Sep 22 13:15:01 localhost ./opensips[6263]: DBG:dialog:dlg_onroute: 
> route param is '475.89859855' (len=12)/
> /Sep 22 13:15:01 localhost ./opensips[6263]: DBG:dialog:lookup_dlg: 
> ref dlg 0x7ff790731ab0 with 1 -> 4/
> /Sep 22 13:15:01 localhost ./opensips[6263]: DBG:dialog:lookup_dlg: 
> dialog id=1435064472 found on entry 1396/
> /Sep 22 13:15:01 localhost ./opensips[6263]: 
> DBG:dialog:next_state_dlg: dialog 0x7ff790731ab0 changed from state 4 
> to state 4, due event 6/
> /Sep 22 13:15:01 localhost ./opensips[6263]: DBG:dialog:dlg_onroute: 
> sequential request successfully processed (dst_leg=1)/
> /Sep 22 13:15:01 localhost ./opensips[6263]: DBG:dialog:dlg_onroute: 
> dialog_timeout: 7200/
> /Sep 22 13:15:01 localhost ./opensips[6263]: DBG:dialog:unref_dlg: 
> unref dlg 0x7ff790731ab0 with 1 -> 3 in entry 0x7ff7906f1280/
> /Sep 22 13:15:01 localhost ./opensips[6263]: DBG:dialog:unref_dlg: 
> unref dlg 0x7ff7907325b0 with 1 -> 0 in entry 0x7ff7906e7a00/
> /Sep 22 13:15:01 localhost ./opensips[6263]: DBG:dialog:unref_dlg: ref 
> <=0 for dialog 0x7ff7907325b0/
> /Sep 22 13:15:01 localhost ./opensips[6263]: DBG:dialog:destroy_dlg: 
> destroying dialog 0x7ff7907325b0/
> /Sep 22 13:15:01 localhost ./opensips[6263]: DBG:dialog:destroy_dlg: 
> dlg expired or not in list - dlg 0x7ff7907325b0 [176:7110971] with 
> clid 'NTY2YzcxMmQ0MGFiZmYwMzkxOWU2NjIyZWU3YzUyYWI.' and tags 
> '72028e07' '15830SIPpTag019'/
> /Sep 22 13:15:01 localhost ./opensips[6263]: 
> DBG:dialog:run_dlg_callbacks: dialog=0x7ff7907325b0, type=2048/
> /Sep 22 13:15:05 localhost ./opensips[6263]: 
> DBG:dialog:next_state_dlg: unref dlg 0x7ff790731ab0 with 1 -> 2 in 
> entry 0x7ff7906f1280/
> /Sep 22 13:15:05 localhost ./opensips[6263]: 
> DBG:dialog:next_state_dlg: dialog 0x7ff790731ab0 changed from state 4 
> to state 4, due event 1/
>
>
>
> Also please note that I am using different database backends in same 
> cfg like for dispatcher module DBMYSQL, for dialog, usrloc DBTEXT and 
> for acc DBFLATSTORE.
>
> Regards,
> Husnain Taseer
>
>
> _______________________________________________
> Users mailing list
> Users at lists.opensips.org
> http://lists.opensips.org/cgi-bin/mailman/listinfo/users

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20160923/ffb82541/attachment-0001.htm>

More information about the Users mailing list