2021-09-17 09:02:40.283442 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f98780ffd80 released. Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->testinextrix] continue=true Dialplan: sofia/default/0720692958@41.160.32.115:5060 Date/Time Match (PASS) [testinextrix] break=never Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(office_status=open) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(office_status=open) 2021-09-17 09:02:40.283442 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [office_status]=[open] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(extensions=0731898326#) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(extensions=0731898326#) 2021-09-17 09:02:40.283442 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [extensions]=[0731898326#] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(no_answer_call_type=12) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(no_answer_call_type=12) 2021-09-17 09:02:40.283442 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [no_answer_call_type]=[12] Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->testinextrix] continue=true Dialplan: sofia/default/0720692958@41.160.32.115:5060 Absolute Condition [testinextrix] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(timezone=Africa/Johannesburg) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(timezone=Africa/Johannesburg) 2021-09-17 09:02:40.283442 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [timezone]=[Africa/Johannesburg] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Date/TimeMatch (FAIL) [testinextrix] break=never Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->testinextrix] continue=true Dialplan: sofia/default/0720692958@41.160.32.115:5060 Absolute Condition [testinextrix] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(timezone=Africa/Johannesburg) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(timezone=Africa/Johannesburg) 2021-09-17 09:02:40.283442 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [timezone]=[Africa/Johannesburg] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Date/TimeMatch (FAIL) [testinextrix] break=never Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->testinextrix] continue=true Dialplan: sofia/default/0720692958@41.160.32.115:5060 Absolute Condition [testinextrix] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(timezone=Africa/Johannesburg) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(timezone=Africa/Johannesburg) 2021-09-17 09:02:40.283442 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [timezone]=[Africa/Johannesburg] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Date/TimeMatch (FAIL) [testinextrix] break=never Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->tod route, x0103130012] continue=false Dialplan: sofia/default/0720692958@41.160.32.115:5060 Regex (PASS) [tod route, x0103130012] destination_number(0103130012) =~ /^(\+?)?(0103130012)$/ break=on-false Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action execute_extension(0103130012_${office_status}) 2021-09-17 09:02:40.283442 [DEBUG] switch_core_state_machine.c:286 (sofia/default/0720692958@41.160.32.115:5060) State Change CS_ROUTING -> CS_EXECUTE 2021-09-17 09:02:40.283442 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0720692958@41.160.32.115:5060) State ROUTING going to sleep 2021-09-17 09:02:40.283442 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0720692958@41.160.32.115:5060) Running State Change CS_EXECUTE (Cur 1 Tot 2132) 2021-09-17 09:02:40.283442 [DEBUG] switch_core_state_machine.c:650 (sofia/default/0720692958@41.160.32.115:5060) State EXECUTE 2021-09-17 09:02:40.283442 [DEBUG] mod_sofia.c:198 sofia/default/0720692958@41.160.32.115:5060 SOFIA EXECUTE 2021-09-17 09:02:40.283442 [DEBUG] switch_core_state_machine.c:328 sofia/default/0720692958@41.160.32.115:5060 Standard EXECUTE EXECUTE sofia/default/0720692958@41.160.32.115:5060 execute_extension(0103130012_open) 2021-09-17 09:02:40.283442 [INFO] mod_dialplan_xml.c:637 Processing 0720692958 <0720692958>->0103130012_open in context default 2021-09-17 09:02:40.283442 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f98780ffd80 Connected. 2021-09-17 09:02:40.283442 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes') 2021-09-17 09:02:40.283442 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons 2021-09-17 09:02:40.303219 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] blind_flag: 0 2021-09-17 09:02:40.303219 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Dialed number : 0103130012 2021-09-17 09:02:40.303219 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '0103130012' limit 1 2021-09-17 09:02:40.303219 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '0103130012' AND status=0 limit 1 2021-09-17 09:02:40.323208 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '0103130012' and status=0 LIMIT 1 2021-09-17 09:02:40.323208 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Caller Id name / number : 0720692958 / 2021-09-17 09:02:40.323208 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0103130012" LIMIT 1 2021-09-17 09:02:40.323208 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Call direction : inbound 2021-09-17 09:02:40.323208 [INFO] switch_cpp.cpp:1365 [ASTPP] [Accountcode : 3673942894] 2021-09-17 09:02:40.323208 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE number = "3673942894" AND deleted = 0 limit 1 2021-09-17 09:02:40.343222 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number ="0103130012" AND (accountid = 0 OR status = 1) LIMIT 1 2021-09-17 09:02:40.343222 [NOTICE] switch_cpp.cpp:1365 [ASTPP] Localization Id: 5 2021-09-17 09:02:40.343222 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate,dst_base_cid FROM localization WHERE id = 5 AND status=0 limit 1 2021-09-17 09:02:40.363245 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PACKAGE_INFO] Call Direction : inbound 2021-09-17 09:02:40.363245 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PACKAGE_INFO] DID ACCOUNT ID : 23 2021-09-17 09:02:40.363245 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PACKAGE_INFO] Query :SELECT *,P.id as package_id,P.product_id as product_id FROM packages_view as P inner join package_patterns as PKGPTR on P.product_id = PKGPTR.product_id WHERE (patterns = '^0103130012.*' OR patterns = '^010313001.*' OR patterns = '^01031300.*' OR patterns = '^0103130.*' OR patterns = '^010313.*' OR patterns = '^01031.*' OR patterns = '^0103.*' OR patterns = '^010.*' OR patterns = '^01.*' OR patterns = '^0.*' OR patterns ='--') AND accountid = 23 ORDER BY LENGTH(PKGPTR.patterns) DESC 2021-09-17 09:02:40.363245 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_SPEEDDIAL] Query :SELECT A.number FROM speed_dial as A,accounts as B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.speed_num ="0103130012" AND A.accountid = '3' limit 1 2021-09-17 09:02:40.383213 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 0103130012 2021-09-17 09:02:40.383213 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0103130012" LIMIT 1 2021-09-17 09:02:40.383213 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] New Call Direction : inbound 2021-09-17 09:02:40.383213 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type FROM call_barring WHERE ((number = '0103130012' OR number = '010313001' OR number = '01031300' OR number = '0103130' OR number = '010313' OR number = '01031' OR number = '0103' OR number = '010' OR number = '01' OR number = '0' OR number ='--') OR (number = '0103130012*' OR number = '010313001*' OR number = '01031300*' OR number = '0103130*' OR number = '010313*' OR number = '01031*' OR number = '0103*' OR number = '010*' OR number = '01*' OR number = '0*' OR number ='--') OR (number = '' OR number = ' 2021-09-17 09:02:40.503391 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET domains] Query :SELECT * FROM domains WHERE accountid = 23 limit 1 2021-09-17 09:02:40.503391 [WARNING] switch_cpp.cpp:1365 [ASTPP] [XML] User Domain : Electronicconnect.nebular.co.za 2021-09-17 09:02:40.503391 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [XML] Custom Function Name :: custom_inbound_11 2021-09-17 09:02:40.503391 [INFO] switch_cpp.cpp:1365 [ASTPP] [TIME_COND] timecondition_id : 13 2021-09-17 09:02:40.503391 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Functions] [GET_TIME_CONDITION_QUERY] Query :SELECT * from time_condition WHERE id = '13' and status =0 LIMIT 1 2021-09-17 09:02:40.503391 [DEBUG] switch_cpp.cpp:1365 [ASTPP] time_condition::::::::::::::::::::::::2029 2021-09-17 09:02:40.503391 [DEBUG] switch_cpp.cpp:1365 [ASTPP] custom_function_name::::::::::::::::::::::::2029 2021-09-17 09:02:40.503391 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Generated XML:

2021-09-17 09:02:40.523228 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f98780ffd80 released. Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->testinextrix] continue=true Dialplan: sofia/default/0720692958@41.160.32.115:5060 Date/Time Match (PASS) [testinextrix] break=never Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(office_status=open) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(office_status=open) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [office_status]=[open] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(extensions=0731898326#) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(extensions=0731898326#) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [extensions]=[0731898326#] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(no_answer_call_type=12) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(no_answer_call_type=12) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [no_answer_call_type]=[12] Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->testinextrix] continue=true Dialplan: sofia/default/0720692958@41.160.32.115:5060 Absolute Condition [testinextrix] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(timezone=Africa/Johannesburg) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(timezone=Africa/Johannesburg) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [timezone]=[Africa/Johannesburg] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Date/TimeMatch (FAIL) [testinextrix] break=never Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->testinextrix] continue=true Dialplan: sofia/default/0720692958@41.160.32.115:5060 Absolute Condition [testinextrix] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(timezone=Africa/Johannesburg) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(timezone=Africa/Johannesburg) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [timezone]=[Africa/Johannesburg] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Date/TimeMatch (FAIL) [testinextrix] break=never Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->testinextrix] continue=true Dialplan: sofia/default/0720692958@41.160.32.115:5060 Absolute Condition [testinextrix] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(timezone=Africa/Johannesburg) INLINE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(timezone=Africa/Johannesburg) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [timezone]=[Africa/Johannesburg] Dialplan: sofia/default/0720692958@41.160.32.115:5060 Date/TimeMatch (FAIL) [testinextrix] break=never Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->tod route, x0103130012] continue=false Dialplan: sofia/default/0720692958@41.160.32.115:5060 Regex (FAIL) [tod route, x0103130012] destination_number(0103130012_open) =~ /^(\+?)?(0103130012)$/ break=on-false Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->office is open] continue=false Dialplan: sofia/default/0720692958@41.160.32.115:5060 Regex (PASS) [office is open] destination_number(0103130012_open) =~ /^(\+?)?(0103130012_open)$/ break=on-false Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(domain_name=Electronicconnect.nebular.co.za) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(set_extensions=${extensions}) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(no_answer_flag=true) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(no_answer_call_type=${no_answer_call_type}) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(no_answer_number=${extensions}) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action transfer(23 XML default) 2021-09-17 09:02:40.523228 [NOTICE] switch_core_session.c:2914 Execute set(domain_name=Electronicconnect.nebular.co.za) EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(domain_name=Electronicconnect.nebular.co.za) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [domain_name]=[Electronicconnect.nebular.co.za] 2021-09-17 09:02:40.523228 [NOTICE] switch_core_session.c:2914 Execute set(set_extensions=${extensions}) EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(set_extensions=0731898326#) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [set_extensions]=[0731898326#] 2021-09-17 09:02:40.523228 [NOTICE] switch_core_session.c:2914 Execute set(no_answer_flag=true) EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(no_answer_flag=true) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [no_answer_flag]=[true] 2021-09-17 09:02:40.523228 [NOTICE] switch_core_session.c:2914 Execute set(no_answer_call_type=${no_answer_call_type}) EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(no_answer_call_type=12) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [no_answer_call_type]=[12] 2021-09-17 09:02:40.523228 [NOTICE] switch_core_session.c:2914 Execute set(no_answer_number=${extensions}) EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(no_answer_number=0731898326#) 2021-09-17 09:02:40.523228 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [no_answer_number]=[0731898326#] 2021-09-17 09:02:40.523228 [NOTICE] switch_core_session.c:2914 Execute transfer(23 XML default) EXECUTE sofia/default/0720692958@41.160.32.115:5060 transfer(23 XML default) 2021-09-17 09:02:40.523228 [DEBUG] switch_ivr.c:2165 (sofia/default/0720692958@41.160.32.115:5060) State Change CS_EXECUTE -> CS_ROUTING 2021-09-17 09:02:40.523228 [NOTICE] switch_ivr.c:2172 Transfer sofia/default/0720692958@41.160.32.115:5060 to XML[23@default] 2021-09-17 09:02:40.523228 [DEBUG] switch_core_state_machine.c:650 (sofia/default/0720692958@41.160.32.115:5060) State EXECUTE going to sleep 2021-09-17 09:02:40.523228 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0720692958@41.160.32.115:5060) Running State Change CS_ROUTING (Cur 1 Tot 2132) 2021-09-17 09:02:40.523228 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0720692958@41.160.32.115:5060) State ROUTING 2021-09-17 09:02:40.523228 [DEBUG] mod_sofia.c:143 sofia/default/0720692958@41.160.32.115:5060 SOFIA ROUTING 2021-09-17 09:02:40.523228 [DEBUG] switch_core_state_machine.c:236 sofia/default/0720692958@41.160.32.115:5060 Standard ROUTING 2021-09-17 09:02:40.523228 [INFO] mod_dialplan_xml.c:637 Processing 0720692958 <0720692958>->23 in context default 2021-09-17 09:02:40.523228 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f98780ffd80 Connected. 2021-09-17 09:02:40.523228 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes') 2021-09-17 09:02:40.523228 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons 2021-09-17 09:02:40.543463 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] blind_flag: 0 2021-09-17 09:02:40.543463 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Dialed number : 23 2021-09-17 09:02:40.543463 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '23' limit 1 2021-09-17 09:02:40.563221 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '23' AND status=0 limit 1 2021-09-17 09:02:40.563221 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '23' and status=0 LIMIT 1 2021-09-17 09:02:40.563221 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Caller Id name / number : 0720692958 / 2021-09-17 09:02:40.563221 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="23" LIMIT 1 2021-09-17 09:02:40.583222 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.id as sip_id,sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as accounts ,domains WHERE accounts.id=domains.accountid AND accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="23" AND domains.domain="156.38.231.106" limit 1 2021-09-17 09:02:40.583222 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Call direction : outbound 2021-09-17 09:02:40.583222 [INFO] switch_cpp.cpp:1365 [ASTPP] [Accountcode : 3673942894] 2021-09-17 09:02:40.583222 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE number = "3673942894" AND deleted = 0 limit 1 2021-09-17 09:02:40.603753 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^23.*' OR blocked_patterns = '^2.*' OR blocked_patterns ='--') AND accountid = 3 limit 1 2021-09-17 09:02:40.603753 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number ="23" AND (accountid = 0 OR status = 1) LIMIT 1 2021-09-17 09:02:40.623219 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE id = "23" AND deleted = 0 limit 1 2021-09-17 09:02:40.623219 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^23.*' OR blocked_patterns = '^2.*' OR blocked_patterns ='--') AND accountid = 23 limit 1 2021-09-17 09:02:40.643217 [DEBUG] switch_cpp.cpp:1365 [ASTPP] Generated ringgroup_no_answer_forward:23 2021-09-17 09:02:40.643217 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET domains] Query :SELECT * FROM domains WHERE accountid = 23 limit 1 2021-09-17 09:02:40.643217 [WARNING] switch_cpp.cpp:1365 [ASTPP] [user_domain] user_domainElectronicconnect.nebular.co.za 2021-09-17 09:02:40.643217 [INFO] switch_cpp.cpp:1365 [ASTPP] [PBX] call_type : 12 2021-09-17 09:02:40.643217 [WARNING] switch_cpp.cpp:1365 [ASTPP] Time-Codtion Pstn Call 2021-09-17 09:02:40.643217 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [get_accounts_info] Query :SELECT * FROM accounts WHERE id = 23 and status = 0 limit 1 2021-09-17 09:02:40.663916 [DEBUG] switch_cpp.cpp:1365 [ASTPP] Generated XML:

2021-09-17 09:02:40.663916 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f98780ffd80 released. Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->23] continue=false Dialplan: sofia/default/0720692958@41.160.32.115:5060 Regex (PASS) [23] destination_number(23) =~ /23/ break=on-false Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action export(did_user_domain=156.38.231.106) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(continue_on_fail=TRUE) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(no_answer_flag=false) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(did_calltype=12) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(did_extensions=0731898326#) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(accountcode=386976) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action transfer(0731898326 XML default) 2021-09-17 09:02:40.663916 [DEBUG] switch_core_state_machine.c:286 (sofia/default/0720692958@41.160.32.115:5060) State Change CS_ROUTING -> CS_EXECUTE 2021-09-17 09:02:40.663916 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0720692958@41.160.32.115:5060) State ROUTING going to sleep 2021-09-17 09:02:40.663916 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0720692958@41.160.32.115:5060) Running State Change CS_EXECUTE (Cur 1 Tot 2132) 2021-09-17 09:02:40.663916 [DEBUG] switch_core_state_machine.c:650 (sofia/default/0720692958@41.160.32.115:5060) State EXECUTE 2021-09-17 09:02:40.663916 [DEBUG] mod_sofia.c:198 sofia/default/0720692958@41.160.32.115:5060 SOFIA EXECUTE 2021-09-17 09:02:40.663916 [DEBUG] switch_core_state_machine.c:328 sofia/default/0720692958@41.160.32.115:5060 Standard EXECUTE EXECUTE sofia/default/0720692958@41.160.32.115:5060 export(did_user_domain=156.38.231.106) 2021-09-17 09:02:40.663916 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [did_user_domain]=[156.38.231.106] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(continue_on_fail=TRUE) 2021-09-17 09:02:40.663916 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [continue_on_fail]=[TRUE] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(no_answer_flag=false) 2021-09-17 09:02:40.663916 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [no_answer_flag]=[false] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(did_calltype=12) 2021-09-17 09:02:40.663916 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [did_calltype]=[12] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(did_extensions=0731898326#) 2021-09-17 09:02:40.663916 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [did_extensions]=[0731898326#] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(accountcode=386976) 2021-09-17 09:02:40.663916 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [accountcode]=[386976] EXECUTE sofia/default/0720692958@41.160.32.115:5060 transfer(0731898326 XML default) 2021-09-17 09:02:40.663916 [DEBUG] switch_ivr.c:2165 (sofia/default/0720692958@41.160.32.115:5060) State Change CS_EXECUTE -> CS_ROUTING 2021-09-17 09:02:40.663916 [NOTICE] switch_ivr.c:2172 Transfer sofia/default/0720692958@41.160.32.115:5060 to XML[0731898326@default] 2021-09-17 09:02:40.663916 [DEBUG] switch_core_state_machine.c:650 (sofia/default/0720692958@41.160.32.115:5060) State EXECUTE going to sleep 2021-09-17 09:02:40.663916 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0720692958@41.160.32.115:5060) Running State Change CS_ROUTING (Cur 1 Tot 2132) 2021-09-17 09:02:40.663916 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0720692958@41.160.32.115:5060) State ROUTING 2021-09-17 09:02:40.663916 [DEBUG] mod_sofia.c:143 sofia/default/0720692958@41.160.32.115:5060 SOFIA ROUTING 2021-09-17 09:02:40.663916 [DEBUG] switch_core_state_machine.c:236 sofia/default/0720692958@41.160.32.115:5060 Standard ROUTING 2021-09-17 09:02:40.663916 [INFO] mod_dialplan_xml.c:637 Processing 0720692958 <0720692958>->0731898326 in context default 2021-09-17 09:02:40.663916 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f98780ffd80 Connected. 2021-09-17 09:02:40.663916 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes') 2021-09-17 09:02:40.683207 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons 2021-09-17 09:02:40.683207 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] blind_flag: 0 2021-09-17 09:02:40.683207 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Dialed number : 0731898326 2021-09-17 09:02:40.683207 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '0731898326' limit 1 2021-09-17 09:02:40.703212 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '0731898326' AND status=0 limit 1 2021-09-17 09:02:40.703212 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '0731898326' and status=0 LIMIT 1 2021-09-17 09:02:40.723806 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Caller Id name / number : 0720692958 / 2021-09-17 09:02:40.723806 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0731898326" LIMIT 1 2021-09-17 09:02:40.723806 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.id as sip_id,sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as accounts ,domains WHERE accounts.id=domains.accountid AND accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="0731898326" AND domains.domain="156.38.231.106" limit 1 2021-09-17 09:02:40.723806 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Call direction : outbound 2021-09-17 09:02:40.723806 [INFO] switch_cpp.cpp:1365 [ASTPP] [Accountcode : 386976] 2021-09-17 09:02:40.723806 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE number = "386976" AND deleted = 0 limit 1 2021-09-17 09:02:40.744884 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^0731898326.*' OR blocked_patterns = '^073189832.*' OR blocked_patterns = '^07318983.*' OR blocked_patterns = '^0731898.*' OR blocked_patterns = '^073189.*' OR blocked_patterns = '^07318.*' OR blocked_patterns = '^0731.*' OR blocked_patterns = '^073.*' OR blocked_patterns = '^07.*' OR blocked_patterns = '^0.*' OR blocked_patterns ='--') AND accountid = 23 limit 1 2021-09-17 09:02:40.744884 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number ="0731898326" AND (accountid = 0 OR status = 1) LIMIT 1 2021-09-17 09:02:40.764101 [NOTICE] switch_cpp.cpp:1365 [ASTPP] Localization Id: 3 2021-09-17 09:02:40.764101 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate,dst_base_cid FROM localization WHERE id = 3 AND status=0 limit 1 2021-09-17 09:02:40.764101 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"27/0,00/99".....0731898326 2021-09-17 09:02:40.764101 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"27/0,00/99".....0731898326 2021-09-17 09:02:40.764101 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PACKAGE_INFO] Query :SELECT *,P.id as package_id,P.product_id as product_id FROM packages_view as P inner join package_patterns as PKGPTR on P.product_id = PKGPTR.product_id WHERE (patterns = '^0731898326.*' OR patterns = '^073189832.*' OR patterns = '^07318983.*' OR patterns = '^0731898.*' OR patterns = '^073189.*' OR patterns = '^07318.*' OR patterns = '^0731.*' OR patterns = '^073.*' OR patterns = '^07.*' OR patterns = '^0.*' OR patterns ='--') AND accountid = 23 ORDER BY LENGTH(PKGPTR.patterns) DESC 2021-09-17 09:02:40.783932 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_SPEEDDIAL] Query :SELECT A.number FROM speed_dial as A,accounts as B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.speed_num ="0731898326" AND A.accountid = '23' limit 1 2021-09-17 09:02:40.783932 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 0731898326 2021-09-17 09:02:40.783932 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0731898326" LIMIT 1 2021-09-17 09:02:40.803211 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.id as sip_id,sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as accounts ,domains WHERE accounts.id=domains.accountid AND accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="0731898326" AND domains.domain="156.38.231.106" limit 1 2021-09-17 09:02:40.803211 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] New Call Direction : outbound 2021-09-17 09:02:40.803211 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type FROM call_barring WHERE ((number = '0731898326' OR number = '073189832' OR number = '07318983' OR number = '0731898' OR number = '073189' OR number = '07318' OR number = '0731' OR number = '073' OR number = '07' OR number = '0' OR number ='--') OR (number = '0731898326*' OR number = '073189832*' OR number = '07318983*' OR number = '0731898*' OR number = '073189*' OR number = '07318*' OR number = '0731*' OR number = '073*' OR number = '07*' OR number = '0*' OR number ='--') OR (number = '' OR number = '

2021-09-17 09:02:41.003217 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f98780ffd80 released. Dialplan: sofia/default/0720692958@41.160.32.115:5060 parsing [default->0731898326] continue=false Dialplan: sofia/default/0720692958@41.160.32.115:5060 Regex (PASS) [0731898326] destination_number(0731898326) =~ /0731898326/ break=on-false Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(effective_destination_number=0731898326) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(bridge_pre_execute_bleg_app=sched_hangup) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(bridge_pre_execute_bleg_data=+6000 normal_clearing) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(callstart=2021-09-17 07:02:40) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(hangup_after_bridge=true) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(continue_on_fail=TRUE) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(account_id=23) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(parent_id=13) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(entity_id=0) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(call_processed=internal) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(call_direction=outbound) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(accountname=default) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(origination_rates=ID:172625|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.49000|INC:1|INITIALBLOCK:1|RATEGROUP:17|MARKUP:0|CI:0|ACCID:23||ID:271833|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.24960|INC:1|INITIALBLOCK:1|RATEGROUP:21|MARKUP:0|CI:0|ACCID:13) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(original_caller_id_name=0720692958) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action limit(db 386976 user_386976 5 ) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action limit(db 778509 user_778509 10 ) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(effective_caller_id_name=0720692958) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(calltype=STANDARD) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(termination_rates=ID:3|CODE:^0.*|DESTINATION:South Africa|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:1|INITIALBLOCK:1|TRUNK:5|PROVIDER:3) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(trunk_id=5) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(provider_id=3) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(rate_flag=0) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(force_trunk_flag=172625) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action export(presence_data=trunk_id=5) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action set(intcall=0) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action export(presence_data=x//13|||Electronic(386976)|||^073.* // D083-MTN // 0.49000 // trunk_id=0|||Liquid // ^0.* // South Africa // 0.00000 // trunk_id=5|||STD|||41.160.32.115|||0.24960 // ^073.* // D083-MTN) Dialplan: sofia/default/0720692958@41.160.32.115:5060 Action bridge([leg_timeout=0,absolute_codec_string=^^:PCMA:G729:PCMU]sofia/gateway/liquid_primary/0731898326;fs_path=sip:156.38.231.106:5060) 2021-09-17 09:02:41.003217 [DEBUG] switch_core_state_machine.c:286 (sofia/default/0720692958@41.160.32.115:5060) State Change CS_ROUTING -> CS_EXECUTE 2021-09-17 09:02:41.003217 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0720692958@41.160.32.115:5060) State ROUTING going to sleep 2021-09-17 09:02:41.003217 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0720692958@41.160.32.115:5060) Running State Change CS_EXECUTE (Cur 1 Tot 2132) 2021-09-17 09:02:41.003217 [DEBUG] switch_core_state_machine.c:650 (sofia/default/0720692958@41.160.32.115:5060) State EXECUTE 2021-09-17 09:02:41.003217 [DEBUG] mod_sofia.c:198 sofia/default/0720692958@41.160.32.115:5060 SOFIA EXECUTE 2021-09-17 09:02:41.003217 [DEBUG] switch_core_state_machine.c:328 sofia/default/0720692958@41.160.32.115:5060 Standard EXECUTE EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(effective_destination_number=0731898326) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [effective_destination_number]=[0731898326] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(bridge_pre_execute_bleg_app=sched_hangup) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [bridge_pre_execute_bleg_app]=[sched_hangup] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(bridge_pre_execute_bleg_data=+6000 normal_clearing) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [bridge_pre_execute_bleg_data]=[+6000 normal_clearing] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(callstart=2021-09-17 07:02:40) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [callstart]=[2021-09-17 07:02:40] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(hangup_after_bridge=true) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [hangup_after_bridge]=[true] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(continue_on_fail=TRUE) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [continue_on_fail]=[TRUE] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(account_id=23) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [account_id]=[23] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(parent_id=13) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [parent_id]=[13] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(entity_id=0) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [entity_id]=[0] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(call_processed=internal) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [call_processed]=[internal] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(call_direction=outbound) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [call_direction]=[outbound] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(accountname=default) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [accountname]=[default] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(origination_rates=ID:172625|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.49000|INC:1|INITIALBLOCK:1|RATEGROUP:17|MARKUP:0|CI:0|ACCID:23||ID:271833|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.24960|INC:1|INITIALBLOCK:1|RATEGROUP:21|MARKUP:0|CI:0|ACCID:13) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [origination_rates]=[ID:172625|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.49000|INC:1|INITIALBLOCK:1|RATEGROUP:17|MARKUP:0|CI:0|ACCID:23||ID:271833|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.24960|INC:1|INITIALBLOCK:1|RATEGROUP:21|MARKUP:0|CI:0|ACCID:13] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(original_caller_id_name=0720692958) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [original_caller_id_name]=[0720692958] EXECUTE sofia/default/0720692958@41.160.32.115:5060 limit(db 386976 user_386976 5 ) 2021-09-17 09:02:41.003217 [DEBUG] switch_limit.c:126 incr called: 386976_user_386976 max:5, interval:0 2021-09-17 09:02:41.003217 [DEBUG] mod_db.c:194 Usage for 386976_user_386976 is now 1/5 EXECUTE sofia/default/0720692958@41.160.32.115:5060 limit(db 778509 user_778509 10 ) 2021-09-17 09:02:41.003217 [DEBUG] switch_limit.c:126 incr called: 778509_user_778509 max:10, interval:0 2021-09-17 09:02:41.003217 [DEBUG] mod_db.c:194 Usage for 778509_user_778509 is now 1/10 EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(effective_caller_id_name=0720692958) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [effective_caller_id_name]=[0720692958] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(calltype=STANDARD) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [calltype]=[STANDARD] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(termination_rates=ID:3|CODE:^0.*|DESTINATION:South Africa|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:1|INITIALBLOCK:1|TRUNK:5|PROVIDER:3) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [termination_rates]=[ID:3|CODE:^0.*|DESTINATION:South Africa|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:1|INITIALBLOCK:1|TRUNK:5|PROVIDER:3] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(trunk_id=5) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [trunk_id]=[5] EXECUTE sofia/default/0720692958@41.160.32.115:5060 set(provider_id=3) 2021-09-17 09:02:41.003217 [DEBUG] mod_dptools.c:1548 SET sofia/default/0720692958@41.160.32.115:5060 [provider_id]=[3]