[SR-Users] Problems with avp_db_load

Kevin Bushong kbushong at carnegietechnologies.com
Fri Mar 31 20:35:54 CEST 2017


Look like my attachment flagged for moderator, so I’m sending this email again without the full syslog attached.

From: Kevin Bushong
Sent: Friday, March 31, 2017 10:12 AM
To: miconda at gmail.com; Kamailio (SER) - Users Mailing List <sr-users at lists.sip-router.org>
Subject: RE: [SR-Users] Problems with avp_db_load

Oops.  Well that explains it.  Here is the portion of the debug I believe is relevant.   I’ve also attached the full syslog in case you need it.

I suspect this is the line that is the problem, but I’m not sure how to fix it:

Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: siptrace [siptrace.c:775]: sip_trace_store_db(): database connection not initialized

Thanks

Kevin



(14606) ERROR: <script>: Fri Mar 31 08:51:29 2017 Call to 15703771993 made it into route[LOCATION] block
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) ERROR: <script>: Fri Mar 31 08:51:29 2017 Call to 15703771993 made it into WITH_CFWD in route[LOCATION] block
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) ERROR: <script>: script should load from DB usr_preferences next11(14615) DEBUG: <core> [parser/msg_parser.c:605]: parse_msg(): SIP Reply  (status):
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/msg_parser.c:607]: parse_msg():  version: <SIP/2.0>
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/msg_parser.c:609]: parse_msg():  status:  <200>
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/msg_parser.c:611]: parse_msg():  reason:  <OK>
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_addr_spec.c:171]: parse_to_param(): DEBUG: add_param: tag=10002030710893
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_addr_spec.c:871]: parse_addr_spec(): end of header reached, state=29
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/msg_parser.c:171]: get_hdr_field(): <To> [75]; uri=[sip:15703771993 at limitless.sip.carnegietechnologies.com]
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/msg_parser.c:172]: get_hdr_field(): to body [sip:15703771993 at limitless.sip.carnegietechnologies.com]
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK38da.2ef31f0c72c8f2c0b9dd76e2865a2dc3.0>; state=6
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <172.16.128.140>; state=6
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 236, <i> = <91>; state=9
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_via.c:2685]: parse_via(): parse_via: next_via
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <172.16.128.135>; state=6
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <55579>; state=6
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPj6505d775-c66a-4f3a-b76a-d87b1e84f6be>; state=6
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/msg_parser.c:486]: parse_headers(): Via found, flags=2
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/msg_parser.c:488]: parse_headers(): this is the first via
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [receive.c:178]: receive_msg(): After parse_msg...
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=0 T start=0xffffffffffffffff
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <24412> <PRACK>
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_lookup.c:888]: t_reply_matching(): DEBUG: t_reply_matching: hash 44419 label 0 branch 0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_lookup.c:943]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7f5a78216e40)!
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7f5a78216e40, callback type 2, id 0 entered
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_addr_spec.c:171]: parse_to_param(): DEBUG: add_param: tag=b9d6ff68-2bb6-405b-bf20-dd4f0f68878f
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/parse_addr_spec.c:871]: parse_addr_spec(): end of header reached, state=29
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: siptrace [siptrace.c:775]: sip_trace_store_db(): database connection not initialized
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: siptrace [siptrace.c:1896]: pipport2su(): the port string is 5060
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: siptrace [siptrace.c:1896]: pipport2su(): the port string is 5085
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [proxy.c:265]: mk_proxy(): doing DNS lookup...
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: siptrace [siptrace.c:1708]: trace_send_hep_duplicate(): setting up the socket_info
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [forward.c:174]: get_out_socket(): socket determined: 0x7f5a7db99ea0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7f5a78216e40, callback type 2, id 0 entered
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: dialog [dlg_hash.c:690]: dlg_lookup(): ref dlg 0x7f5a782062b0 with 1 -> 2
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: dialog [dlg_hash.c:692]: dlg_lookup(): dialog id=4198 found on entry 2114
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: dialog [dlg_profile.c:530]: set_current_dialog(): setting current dialog [2114:4198]
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: dialog [dlg_hash.c:922]: dlg_unref_helper(): unref op on 0x7f5a782062b0 with 1 from dlg_hash.c:940
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: dialog [dlg_hash.c:926]: dlg_unref_helper(): unref dlg 0x7f5a782062b0 with 1 -> 1
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_lookup.c:1080]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=1 T end=0x7f5a78216e40
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_reply.c:2161]: reply_received(): DEBUG: reply_received: org. status uas=0, uac[0]=0 local=0 is_invite=0)
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_reply.c:1233]: t_should_relay_response(): ->>>>>>>>> T_code=0, new_code=200
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_reply.c:1752]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=0 icode=0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/msg_parser.c:183]: get_hdr_field(): content_length=0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [msg_translator.c:2261]: generate_res_buf_from_sip_res(): old size: 539, new size: 423
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [msg_translator.c:2279]: generate_res_buf_from_sip_res(): copied size: orig:319, new: 203, rest: 220 msg=
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: SIP/2.0 200 OK
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: From: sip:15703771055 at limitless.sip.carnegietechnologies.com;tag=b9d6ff68-2bb6-405b-bf20-dd4f0f68878f
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: To: sip:15703771993 at limitless.sip.carnegietechnologies.com;tag=10002030710893
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: Via: SIP/2.0/TCP  172.16.128.135:55579;received=172.16.128.135;rport=55579;branch=z9hG4bKPj6505d775-c66a-4f3a-b76a-d87b1e84f6be;alias
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: Call-ID: 2faac02a-f381-4b8e-8791-ea5941cb1970
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: CSeq: 24412 PRACK
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: Content-Length:    0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [tcp_main.c:2211]: tcpconn_send_put(): tcp connection found (0x7f5a781ee1c8), acquiring fd
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 30(14634) DEBUG: <core> [tcp_main.c:3484]: handle_ser_child(): read response= 7f5a781ee1c8, 2, fd -1 from 11 (14615)
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [tcp_main.c:2221]: tcpconn_send_put(): c=0x7f5a781ee1c8, n=16
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [tcp_main.c:2251]: tcpconn_send_put(): after receive_fd: c= 0x7f5a781ee1c8 n=8 fd=11
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7f5a781ee1c8 n=423 fd=11
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: SIP/2.0 200 OK
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: From: sip:15703771055 at limitless.sip.carnegietechnologies.com;tag=b9d6ff68-2bb6-405b-bf20-dd4f0f68878f
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: To: sip:15703771993 at limitless.sip.carnegietechnologies.com;tag=10002030710893
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: Via: SIP/2.0/TCP  172.16.128.135:55579;received=172.16.128.135;rport=55579;branch=z9hG4bKPj6505d775-c66a-4f3a-b76a-d87b1e84f6be;alias
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: Call-ID: 2faac02a-f381-4b8e-8791-ea5941cb1970
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: CSeq: 24412 PRACK
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: Content-Length:    0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7f5a7dbb1fa0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7f5a78216e40, callback type 8388608, id 0 entered
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 3 columns returned from the query
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: siptrace [siptrace.c:775]: sip_trace_store_db(): database connection not initialized
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7f5a7dbb2130
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: siptrace [siptrace.c:1896]: pipport2su(): the port string is 5085
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7f5a7dbb01e0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: siptrace [siptrace.c:1896]: pipport2su(): the port string is 55579
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7f5a7db996d0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f5a7db996d0)[0]=[value]
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [proxy.c:265]: mk_proxy(): doing DNS lookup...
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7f5a7dbb1920
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f5a7dbb1920)[1]=[attribute]
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: siptrace [siptrace.c:1708]: trace_send_hep_duplicate(): setting up the socket_info
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7f5a7dbb17e8
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f5a7dbb17e8)[2]=[type]
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:99]: db_mysql_get_columns(): use DB1_INT result type
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: db_mysql [km_res.c:168]: db_mysql_convert_rows(): no rows returned from the query
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [forward.c:174]: get_out_socket(): socket determined: 0x7f5a7db99ea0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: avpops [avpops_db.c:265]: db_close_query(): close avp query
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7f5a7db996d0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7f5a7dbb1920
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7f5a7dbb17e8
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7f5a7dbb2130
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: tm [t_reply.c:1593]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7f5a7dbb01e0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7f5a7dbb1fa0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: avpops [avpops_impl.c:415]: ops_dbload_avps(): loaded avps = 0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) ERROR: <script>: DB load should be complete11(14615) DEBUG: dialog [dlg_var.c:86]: cb_dlg_locals_reset(): resetting the local dialog shortcuts on script callback: 2147483652
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 11(14615) DEBUG: <core> [receive.c:322]: receive_msg(): cleaning up
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) ERROR: <script>: SCRIPT: Fri Mar 31 08:51:29 2017 Call Forwarding Unconditional set to <null>
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) ERROR: <script>: SCRIPT: Fri Mar 31 08:51:29 2017 Call Forwarding NoAnswer set to <null>
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) ERROR: <script>: SCRIPT: Fri Mar 31 08:51:29 2017 Call Forwarding Busy set to <null>
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) INFO: avpops [avpops_impl.c:1473]: ops_print_avp(): p=0x7f5a78205bd0, flags=0x0113
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) INFO: avpops [avpops_impl.c:1477]: ops_print_avp(): #011#011#011name=<direction>
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) INFO: avpops [avpops_impl.c:1485]: ops_print_avp(): #011#011#011val_str=<INCOMING / 8>
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: registrar [lookup.c:240]: lookup_helper(): contact for [15703771993] found by address
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: tm [t_lookup.c:1312]: t_newtran(): DEBUG: t_newtran: msg id=1 , global msg id=1 , T on entrance=(nil)
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=16801, isACK=0
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: tm [t_hooks.c:358]: run_reqin_callbacks_internal(): DBG: trans=0x7f5a78233c70, callback type 1, id 0 entered
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: dialog [dlg_handlers.c:722]: dlg_onreq(): dialog creation on config flag
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: dialog [dlg_hash.c:756]: internal_get_dlg(): no dialog callid='9984c9ea-90b3-1235-a08c-0cc47ab00eb4' found
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: dialog [dlg_hash.c:821]: dlg_search(): dialog with callid='9984c9ea-90b3-1235-a08c-0cc47ab00eb4' not found
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: dialog [dlg_hash.c:452]: build_new_dlg(): new dialog on hash 354
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: dialog [dlg_handlers.c:255]: populate_leg_info(): route_set , contact sip:mod_sofia at 172.16.128.140:5060;alias=172.16.128.140~5060~1, cseq 105146280 and bind_addr udp:127.0.0.1:5085
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: dialog [dlg_hash.c:875]: link_dlg(): linking dialog [354:4990]
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: dialog [dlg_hash.c:884]: link_dlg(): ref dlg 0x7f5a782384c8 with 1 -> 1
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: dialog [dlg_cb.c:228]: run_create_callbacks(): dialog=0x7f5a782384c8
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: acc [acc_cdr.c:790]: cdr_on_create(): dialog '0x7f5a782384c8' created! 2(14606) DEBUG: dialog [dlg_var.c:250]: print_lists(): Internal var-list ((nil)):
Mar 31 08:51:29 Limitless-Calling-Server kamailio[14586]: 2(14606) DEBUG: dialog [dlg_var.c:260]: print_lists(): Dialog var-list (0x7f5a78238ae0):





From: Daniel-Constantin Mierla [mailto:miconda at gmail.com]
Sent: Friday, March 31, 2017 7:41 AM
To: Kevin Bushong <kbushong at carnegietechnologies.com<mailto:kbushong at carnegietechnologies.com>>; Kamailio (SER) - Users Mailing List <sr-users at lists.sip-router.org<mailto:sr-users at lists.sip-router.org>>
Subject: Re: [SR-Users] Problems with avp_db_load


By default the second setting of debug is in effect, the one after #!else, respectively:

debug=2
Cheers,
Daniel
On 30.03.17 19:40, Kevin Bushong wrote:
Yes, I ran it as debug=3

#!ifdef WITH_DEBUG
debug=3
log_stderror=yes
#!else
debug=2
log_stderror=no
#!endif


Here is my modparams for the debugger module.

#!ifdef WITH_DEBUG
# ----- debugger params -----
modparam("debugger", "cfgtrace", 1)


I expect debugs as well, but didn’t see any.  Is there some configuration I’m missing?

Thanks,

Kevin


From: Daniel-Constantin Mierla [mailto:miconda at gmail.com]
Sent: Thursday, March 30, 2017 1:37 PM
To: Kevin Bushong <kbushong at carnegietechnologies.com><mailto:kbushong at carnegietechnologies.com>; Kamailio (SER) - Users Mailing List <sr-users at lists.sip-router.org><mailto:sr-users at lists.sip-router.org>
Subject: Re: [SR-Users] Problems with avp_db_load


Are you sure you ran it with debug=3? Because there must be a lot of "DEBUG: ...." log messages.

Cheers,
Daniel

On 30.03.17 16:35, Kevin Bushong wrote:
I hope this helps.

Thanks, Kevin


Mar 30 09:47:26 Limitless-Calling-Server /usr/local/sbin/kamailio[7855]: ERROR: <script>: SCRIPT: Thu Mar 30 09:47:26 2017 15703771055 Registration request inbound for useragent type of pjsua2 Android 2.5.5-svn
Mar 30 09:47:26 Limitless-Calling-Server /usr/local/sbin/kamailio[7855]: ERROR: <script>: SCRIPT: Thu Mar 30 09:47:26 2017 15703771055 registered to usrloc db from 172.16.128.135 from useragent type of pjsua2 Android 2.5.5-svn
Mar 30 09:47:26 Limitless-Calling-Server /usr/local/sbin/kamailio[7855]: ERROR: <script>: SCRIPT: Thu Mar 30 09:47:26 2017 15703771055 Going to PUSHJOIN route 172.16.128.135 from useragent type of pjsua2 Android 2.5.5-svn
Mar 30 09:47:26 Limitless-Calling-Server /usr/local/sbin/kamailio[7855]: INFO: <script>: Got to PUSHJOIN ROUTE
Mar 30 09:47:26 Limitless-Calling-Server /usr/local/sbin/kamailio[7855]: INFO: <script>: tU variable is: 15703771055
Mar 30 09:47:26 Limitless-Calling-Server /usr/local/sbin/kamailio[7855]: INFO: <script>: Value of <null> = <null>
Mar 30 09:47:26 Limitless-Calling-Server /usr/local/sbin/kamailio[7855]: INFO: <script>: hjoin Var is: 0
[...]


--

Daniel-Constantin Mierla

www.twitter.com/miconda<http://www.twitter.com/miconda> -- www.linkedin.com/in/miconda<http://www.linkedin.com/in/miconda>

Kamailio Advanced Training - May 22-24 (USA) - www.asipto.com<http://www.asipto.com>

Kamailio World Conference - May 8-10, 2017 - www.kamailioworld.com<http://www.kamailioworld.com>


--

Daniel-Constantin Mierla

www.twitter.com/miconda<http://www.twitter.com/miconda> -- www.linkedin.com/in/miconda<http://www.linkedin.com/in/miconda>

Kamailio Advanced Training - May 22-24 (USA) - www.asipto.com<http://www.asipto.com>

Kamailio World Conference - May 8-10, 2017 - www.kamailioworld.com<http://www.kamailioworld.com>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20170331/a797e534/attachment.html>


More information about the sr-users mailing list