From Nikunj, 3 Years ago, written in Plain Text.
- view diff
Embed
  1. 2020-11-19 12:15:37.774903 [INFO] mod_dialplan_xml.c:637 Processing 511 <511>->0110720229 in context default
  2. 2020-11-19 12:15:37.774903 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
  3. 2020-11-19 12:15:37.774903 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  4. 2020-11-19 12:15:37.794910 [NOTICE] switch_cpp.cpp:1447 [ASTPP] [xml_handler] Params:
  5. Event-Name: REQUEST_PARAMS
  6. Core-UUID: 7a529bf8-00e7-433b-92b6-35586a85dc31
  7. FreeSWITCH-Hostname: pbx2.conexo.tech
  8. FreeSWITCH-Switchname: pbx2.conexo.tech
  9. FreeSWITCH-IPv4: 212.97.34.173
  10. FreeSWITCH-IPv6: %3A%3A1
  11. Event-Date-Local: 2020-11-19%2012%3A15%3A37
  12. Event-Date-GMT: Thu,%2019%20Nov%202020%2011%3A15%3A37%20GMT
  13. Event-Date-Timestamp: 1605784537774903
  14. Event-Calling-File: mod_dialplan_xml.c
  15. Event-Calling-Function: dialplan_xml_locate
  16. Event-Calling-Line-Number: 608
  17. Event-Sequence: 214969
  18. Channel-State: CS_ROUTING
  19. Channel-Call-State: RINGING
  20. Channel-State-Number: 2
  21. Channel-Name: sofia/default/511%40testnikunj340.netgen.conexopbx.it
  22. Unique-ID: a5b20031-4479-46c4-9197-aebd9b3d563d
  23. Call-Direction: inbound
  24. Presence-Call-Direction: inbound
  25. Channel-HIT-Dialplan: true
  26. Channel-Presence-ID: 511%40testnikunj340.netgen.conexopbx.it
  27. Channel-Call-UUID: a5b20031-4479-46c4-9197-aebd9b3d563d
  28. Answer-State: ringing
  29. Channel-Read-Codec-Name: PCMA
  30. Channel-Read-Codec-Rate: 8000
  31. Channel-Read-Codec-Bit-Rate: 64000
  32. Channel-Write-Codec-Name: PCMA
  33. Channel-Write-Codec-Rate: 8000
  34. Channel-Write-Codec-Bit-Rate: 64000
  35. Caller-Direction: inbound
  36. Caller-Logical-Direction: inbound
  37. Caller-Username: 511
  38. Caller-Dialplan: XML
  39. Caller-Caller-ID-Name: 511
  40. Caller-Caller-ID-Number: 511
  41. Caller-Orig-Caller-ID-Name: 511
  42. Caller-Orig-Caller-ID-Number: 511
  43. Caller-Network-Addr: 212.97.34.174
  44. Caller-ANI: 511
  45. Caller-Destination-Number: 0110720229
  46. Caller-Unique-ID: a5b20031-4479-46c4-9197-aebd9b3d563d
  47. Caller-Source: mod_sofia
  48. Caller-Context: default
  49. Caller-Channel-Name: sofia/default/511%40testnikunj340.netgen.conexopbx.it
  50. Caller-Profile-Index: 1
  51. Caller-Profile-Created-Time: 1605784537774903
  52. Caller-Channel-Created-Time: 1605784537774903
  53. Caller-Channel-Answered-Time: 0
  54. Caller-Channel-Progress-Time: 0
  55. Caller-Channel-Progress-Media-Time: 0
  56. Caller-Channel-Hangup-Time: 0
  57. Caller-Channel-Transfer-Time: 0
  58. Caller-Channel-Resurrect-Time: 0
  59. Caller-Channel-Bridged-Time: 0
  60. Caller-Channel-Last-Hold: 0
  61. Caller-Channel-Hold-Accum: 0
  62. Caller-Screen-Bit: true
  63. Caller-Privacy-Hide-Name: false
  64. Caller-Privacy-Hide-Number: false
  65. variable_direction: inbound
  66. variable_uuid: a5b20031-4479-46c4-9197-aebd9b3d563d
  67. variable_session_id: 1982
  68. variable_sip_from_params: transport%3DUDP
  69. variable_sip_from_user: 511
  70. variable_sip_from_uri: 511%40testnikunj340.netgen.conexopbx.it
  71. variable_sip_from_host: testnikunj340.netgen.conexopbx.it
  72. variable_video_media_flow: disabled
  73. variable_text_media_flow: disabled
  74. variable_channel_name: sofia/default/511%40testnikunj340.netgen.conexopbx.it
  75. variable_sip_call_id: OGZlOTdmYzI4OTVlYjBhMGI0ZDNkZjI2ZTVhZjE2Nzc.
  76. variable_sip_local_network_addr: 212.97.34.173
  77. variable_sip_network_ip: 212.97.34.174
  78. variable_sip_network_port: 5060
  79. variable_sip_invite_stamp: 1605784537774903
  80. variable_sip_received_ip: 212.97.34.174
  81. variable_sip_received_port: 5060
  82. variable_sip_via_protocol: udp
  83. variable_sip_authorized: true
  84. variable_sip_acl_authed_by: default
  85. variable_sip_from_user_stripped: 511
  86. variable_sip_from_tag: 8de01675
  87. variable_sofia_profile_name: default
  88. variable_sofia_profile_url: sip%3Amod_sofia%40212.97.34.173%3A7777
  89. variable_recovery_profile_name: default
  90. variable_sip_invite_route_uri: %3Csip%3A212.97.34.174%3Blr%3Bdid%3D00f.7999dde3%3E
  91. variable_sip_invite_record_route: %3Csip%3A212.97.34.174%3Blr%3Bdid%3D00f.7999dde3%3E
  92. variable_sip_full_via: SIP/2.0/UDP%20212.97.34.174%3A5060%3Bbranch%3Dz9hG4bK73f8.c0b86df2.0,SIP/2.0/UDP%20117.247.91.162%3A57954%3Bbranch%3Dz9hG4bK-d8754z-1376313f5ac0d4d9-1---d8754z-
  93. variable_sip_full_from: %3Csip%3A511%40testnikunj340.netgen.conexopbx.it%3Btransport%3DUDP%3E%3Btag%3D8de01675
  94. variable_sip_full_to: %3Csip%3A0110720229%40testnikunj340.netgen.conexopbx.it%3Btransport%3DUDP%3E
  95. variable_sip_allow: INVITE,%20ACK,%20CANCEL,%20BYE,%20NOTIFY,%20REFER,%20MESSAGE,%20OPTIONS,%20INFO,%20SUBSCRIBE
  96. variable_sip_req_params: transport%3DUDP
  97. variable_sip_req_user: 0110720229
  98. variable_sip_req_uri: 0110720229%40testnikunj340.netgen.conexopbx.it
  99. variable_sip_req_host: testnikunj340.netgen.conexopbx.it
  100. variable_sip_to_params: transport%3DUDP
  101. variable_sip_to_user: 0110720229
  102. variable_sip_to_uri: 0110720229%40testnikunj340.netgen.conexopbx.it
  103. variable_sip_to_host: testnikunj340.netgen.conexopbx.it
  104. variable_sip_contact_params: transport%3DUDP
  105. variable_sip_contact_user: 511
  106. variable_sip_contact_port: 57954
  107. variable_sip_contact_uri: 511%40117.247.91.162%3A57954
  108. variable_sip_contact_host: 117.247.91.162
  109. variable_sip_user_agent: Z%203.3.25608%20r25552
  110. variable_sip_via_host: 212.97.34.174
  111. variable_sip_via_port: 5060
  112. variable_max_forwards: 30
  113. variable_presence_id: 511%40testnikunj340.netgen.conexopbx.it
  114. variable_sip_h_X-AUTH-IP: 117.247.91.162
  115. variable_sip_h_P-Accountcode: 790604
  116. variable_sip_h_P-effective_caller_id_number: 01119217873
  117. variable_switch_r_sdp: v%3D0%0D%0Ao%3DZ%200%200%20IN%20IP4%20117.247.91.162%0D%0As%3DZ%0D%0Ac%3DIN%20IP4%20117.247.91.162%0D%0At%3D0%200%0D%0Am%3Daudio%208000%20RTP/AVP%203%20110%208%200%2098%20101%0D%0Aa%3Drtpmap%3A110%20speex/8000%0D%0Aa%3Drtpmap%3A98%20iLBC/8000%0D%0Aa%3Dfmtp%3A98%20mode%3D20%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-15%0D%0A
  118. variable_ep_codec_string: CORE_PCM_MODULE.PCMA%408000h%4020i%4064000b,CORE_PCM_MODULE.PCMU%408000h%4020i%4064000b
  119. variable_rtp_use_codec_string: PCMA,PCMU,G729
  120. variable_remote_video_media_flow: inactive
  121. variable_remote_text_media_flow: inactive
  122. variable_remote_audio_media_flow: sendrecv
  123. variable_audio_media_flow: sendrecv
  124. variable_remote_media_ip: 117.247.91.162
  125. variable_remote_media_port: 8000
  126. variable_rtp_audio_recv_pt: 8
  127. variable_rtp_use_codec_name: PCMA
  128. variable_rtp_use_codec_rate: 8000
  129. variable_rtp_use_codec_ptime: 20
  130. variable_rtp_use_codec_channels: 1
  131. variable_rtp_last_audio_codec_string: PCMA%408000h%4020i%401c
  132. variable_read_codec: PCMA
  133. variable_original_read_codec: PCMA
  134. variable_read_rate: 8000
  135. variable_original_read_rate: 8000
  136. variable_write_codec: PCMA
  137. variable_write_rate: 8000
  138. variable_dtmf_type: rfc2833
  139. variable_endpoint_disposition: RECEIVED
  140. variable_call_uuid: a5b20031-4479-46c4-9197-aebd9b3d563d
  141. Hunt-Direction: inbound
  142. Hunt-Logical-Direction: inbound
  143. Hunt-Username: 511
  144. Hunt-Dialplan: XML
  145. Hunt-Caller-ID-Name: 511
  146. Hunt-Caller-ID-Number: 511
  147. Hunt-Orig-Caller-ID-Name: 511
  148. Hunt-Orig-Caller-ID-Number: 511
  149. Hunt-Network-Addr: 212.97.34.174
  150. Hunt-ANI: 511
  151. Hunt-Destination-Number: 0110720229
  152. Hunt-Unique-ID: a5b20031-4479-46c4-9197-aebd9b3d563d
  153. Hunt-Source: mod_sofia
  154. Hunt-Context: default
  155. Hunt-Channel-Name: sofia/default/511%40testnikunj340.netgen.conexopbx.it
  156. Hunt-Profile-Index: 1
  157. Hunt-Profile-Created-Time: 1605784537774903
  158. Hunt-Channel-Created-Time: 1605784537774903
  159. Hunt-Channel-Answered-Time: 0
  160. Hunt-Channel-Progress-Time: 0
  161. Hunt-Channel-Progress-Media-Time: 0
  162. Hunt-Channel-Hangup-Time: 0
  163. Hunt-Channel-Transfer-Time: 0
  164. Hunt-Channel-Resurrect-Time: 0
  165. Hunt-Channel-Bridged-Time: 0
  166. Hunt-Channel-Last-Hold: 0
  167. Hunt-Channel-Hold-Accum: 0
  168. Hunt-Screen-Bit: true
  169. Hunt-Privacy-Hide-Name: false
  170. Hunt-Privacy-Hide-Number: false
  171.  
  172.  
  173. 2020-11-19 12:15:37.794910 [INFO] switch_cpp.cpp:1447 [ASTPP] [xml_REQUEST] key_name:
  174. 2020-11-19 12:15:37.794910 [INFO] switch_cpp.cpp:1447 [ASTPP] [xml_REQUEST] key_value:
  175. 2020-11-19 12:15:37.794910 [INFO] switch_cpp.cpp:1447 [ASTPP] [xml_REQUEST] tag_name:
  176. 2020-11-19 12:15:37.794910 [INFO] switch_cpp.cpp:1447 [ASTPP] [xml_REQUEST] section: dialplan
  177. 2020-11-19 12:15:37.794910 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] blind_flag: 0
  178. 2020-11-19 12:15:37.794910 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] Dialed number : 0110720229
  179. 2020-11-19 12:15:37.794910 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '0110720229' limit 1
  180. 2020-11-19 12:15:37.794910 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '0110720229' AND status=0 limit 1
  181. 2020-11-19 12:15:37.794910 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '0110720229' and status=0 LIMIT 1
  182. 2020-11-19 12:15:37.794910 [INFO] switch_cpp.cpp:1447 [ASTPP] SOURCE NUMBER511
  183. 2020-11-19 12:15:37.794910 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION LOCAL SOURCE] Query :SELECT domain,accountid FROM domains WHERE domain = 'testnikunj340.netgen.conexopbx.it' limit 1
  184. 2020-11-19 12:15:37.794910 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION LOCAL DOMAIN] Query :SELECT accountid from sip_devices where accountid = '67' and username = '0110720229' limit 1
  185. 2020-11-19 12:15:37.794910 [WARNING] switch_cpp.cpp:1447 [ASTPP] [FAXER] in custom Caller ID
  186. 2020-11-19 12:15:37.794910 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] Caller Id name / number  : 511 / 01119217873
  187. 2020-11-19 12:15:37.794910 [NOTICE] switch_cpp.cpp:1447 [ASTPP] DID global translation id: 3
  188. 2020-11-19 12:15:37.794910 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 3 AND status=0 limit 1
  189. 2020-11-19 12:15:37.794910 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :"+39/*".....0110720229
  190. 2020-11-19 12:15:37.794910 [DEBUG] switch_cpp.cpp:1447 [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 ="0110720229" LIMIT 1
  191. 2020-11-19 12:15:37.794910 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] Call direction : inbound
  192. 2020-11-19 12:15:37.794910 [INFO] switch_cpp.cpp:1447 [ASTPP] [Accountcode1212 : 790604]
  193. 2020-11-19 12:15:37.794910 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET get_acc_info] Query :SELECT count(id) as id FROM local_number WHERE number =0110720229
  194. 2020-11-19 12:15:37.794910 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE number = "790604" AND deleted = 0 limit 1
  195. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [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 ="0110720229" AND A.accountid = '67' limit 1
  196. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 0110720229
  197. 2020-11-19 12:15:37.814905 [NOTICE] switch_cpp.cpp:1447 [ASTPP] DID global translation id: 3
  198. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 3 AND status=0 limit 1
  199. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :"+39/*".....0110720229
  200. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [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 ="0110720229" LIMIT 1
  201. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] New Call direction : inbound
  202. 2020-11-19 12:15:37.814905 [NOTICE] switch_cpp.cpp:1447 [ASTPP] DID global translation id: 3
  203. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 3 AND status=0 limit 1
  204. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :"+39/*".....0110720229
  205. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number ="0110720229" AND (accountid = 0 OR status = 1) LIMIT 1
  206. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_PACKAGE_INFO] call_direction :inbound
  207. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_PACKAGE_INFO] DID_ACCOUNTID :49
  208. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [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 = '^0110720229.*' OR patterns = '^011072022.*' OR patterns = '^01107202.*' OR patterns = '^0110720.*' OR patterns = '^011072.*' OR patterns = '^01107.*' OR patterns = '^0110.*' OR patterns = '^011.*' OR patterns = '^01.*' OR patterns = '^0.*' OR patterns ='--') AND accountid = 49 ORDER BY LENGTH(PKGPTR.patterns) DESC
  209. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type FROM call_barring WHERE ((number = '0110720229' OR number = '011072022' OR number = '01107202' OR number = '0110720' OR number = '011072' OR number = '01107' OR number = '0110' OR number = '011' OR number = '01' OR number = '0' OR number ='--') OR (number = '0110720229*' OR number = '011072022*' OR number = '01107202*' OR number = '0110720*' OR number = '011072*' OR number = '01107*' OR number = '0110*' OR number = '011*' OR number = '01*' OR number = '0*' OR number ='--') OR (number = '01119217873' OR number = '0111921787' OR number = '011192178' OR number = '01119217' OR number = '0111921' OR number = '011192' OR number = '01119' OR number = '0111' OR number = '011' OR number = '01' OR number = '0' OR number ='--') OR (number = '01119217873*' OR number = '0111921787*' OR number = '011192178*' OR number = '01119217*' OR number = '0111921*' OR number = '011192*' OR number = '01119*' OR number = '0111*' OR number = '011*' OR number = '01*' OR number = '0*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC
  210. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] Call Barring Status : -1
  211. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_PRICELIST_ROUTING_INFO] Query :select id,routing_prefix,pricelist_id_admin from pricelists WHERE (routing_prefix = '0110720229' OR routing_prefix = '011072022' OR routing_prefix = '01107202' OR routing_prefix = '0110720' OR routing_prefix = '011072' OR routing_prefix = '01107' OR routing_prefix = '0110' OR routing_prefix = '011' OR routing_prefix = '01' OR routing_prefix = '0' OR routing_prefix ='--') AND status = 0 and reseller_id = 0 limit 1
  212. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] =============== Account Information ===================
  213. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] User id : 67
  214. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Account code : 790604
  215. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Balance : 5
  216. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Type : 0 [0:prepaid,1:postpaid]
  217. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Ratecard id : 9
  218. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] CID Pool : 0
  219. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] ========================================================
  220. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 9 AND status = 0
  221. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_RATES] call_direction :inbound
  222. 2020-11-19 12:15:37.814905 [NOTICE] switch_cpp.cpp:1447 [ASTPP] DID global translation id: 3
  223. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 3 AND status=0 limit 1
  224. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :"+39/*".....0110720229
  225. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [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 ="0110720229" LIMIT 1
  226. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] call_direction:::::: inbound
  227. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] =============== Rates Information ===================
  228. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] ID : 25
  229. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Connectcost : 0.00000
  230. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Includedseconds : 0
  231. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Cost : 0.00000
  232. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] comment : TORINO TO
  233. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Country Id : 94
  234. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Accid : 67
  235. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] ================================================================
  236. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] [FIND_MAXLENGTH] Your5 balance Accountid 67 !!!
  237. 2020-11-19 12:15:37.814905 [NOTICE] switch_cpp.cpp:1447 [ASTPP] [FIND_MAXLENGTH] Call is free - assigning max length!!! :: 100
  238. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Call Max length duration : 100 minutes
  239. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] [userinfo] INB_FREE:TRUE
  240. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] [userinfo] free_inbound:1
  241. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_OVERRIDE_CALLERID] Query :SELECT callerid_name as cid_name,callerid_number as cid_number,accountid FROM accounts_callerid WHERE accountid = 67 AND status=0 LIMIT 1
  242. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE id = "49" AND deleted = 0 limit 1
  243. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] [userinfo] Actual CustomerInfo XML:67
  244. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] [userinfo] Userinfo XML:67
  245. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] [userinfo] Actual CustomerInfo XML : 67
  246. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET domains] Query :SELECT * FROM domains WHERE accountid = 49 limit 1
  247. 2020-11-19 12:15:37.814905 [WARNING] switch_cpp.cpp:1447 [ASTPP] [user_domain] user_domaincta.conexopbx.it
  248. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [astpp.callingcard.functions.lua - getSystemLanguage - System Language Query] : SELECT * FROM `system` WHERE name = 'default_language' AND is_display=1 limit 1
  249. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] COMING
  250. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [astpp.callingcard.functions.lua - getSystemLanguage - System Language Query] : select name from languages where id = "1" limit 1
  251. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [astpp.callingcard.functions.lua - getSystemLanguage - System Language Value] : English
  252. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [astpp.callingcard.functions.lua - getSystemLanguage - Get language query] : SELECT lang.code AS language_code, lang.name AS language_name FROM `languages` AS lang WHERE name = 'English' LIMIT 1
  253. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [astpp.callingcard.functions.lua - getSystemLanguage - Get language code] : en
  254. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [astpp.callingcard.functions.lua - getSystemLanguage - Get language name] : English
  255. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] Language Code :en
  256. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [astpp.callingcard.functions.lua - getSystemLanguage - Sound path for language] : /usr/share/freeswitch/sounds/en/us/callie/
  257. 2020-11-19 12:15:37.814905 [INFO] switch_cpp.cpp:1447 [ASTPP] maxlength::::::::: 100
  258. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :"+39/*".....511
  259. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :"+39/*".....01119217873
  260. 2020-11-19 12:15:37.814905 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET domains] Query :SELECT * FROM domains WHERE accountid = 49 limit 1
  261. 2020-11-19 12:15:37.834904 [WARNING] switch_cpp.cpp:1447 [ASTPP] [user_domain] user_domaincta.conexopbx.it
  262. 2020-11-19 12:15:37.834904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] custom_function_name:::::::::::::::::::::::::custom_inbound_10
  263. 2020-11-19 12:15:37.834904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] custom_function_name::::::::::1343:::::::::::::::25
  264. 2020-11-19 12:15:37.834904 [WARNING] switch_cpp.cpp:1447 [ASTPP] [user_domain] user_domaincta.conexopbx.it
  265. 2020-11-19 12:15:37.834904 [INFO] switch_cpp.cpp:1447 [ASTPP] [PBX] call_type : 10
  266. 2020-11-19 12:15:37.834904 [INFO] switch_cpp.cpp:1447 [ASTPP] [PBX] call_type : IVR
  267. 2020-11-19 12:15:37.834904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [Functions] [GET_IVR_INFO] Query :SELECT * from pbx_ivr_specification WHERE id = 11 and status=0 LIMIT 1
  268. 2020-11-19 12:15:37.834904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [Functions] [GET_RING_GROUP_INFO] Query :SELECT file_name from pbx_recording WHERE id = '' LIMIT 1
  269. 2020-11-19 12:15:37.834904 [INFO] switch_cpp.cpp:1447 [ASTPP] =============== sandip here===========================
  270. 2020-11-19 12:15:37.834904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [Dialplan] Generated XML:<?xml version="1.0" encoding="UTF-8" standalone="no"?>
  271. <document type="freeswitch/xml">
  272. <section name="dialplan" description="ASTPP Dialplan">
  273. <context name="default">
  274. <extension name="0110720229">
  275. <condition field="destination_number" expression="0110720229">
  276. <action application="set" data="effective_destination_number=0110720229"/>
  277. <action application="set" data="bridge_pre_execute_bleg_app=sched_hangup"/>
  278. <action application="set" data="bridge_pre_execute_bleg_data=+6000 normal_clearing"/>
  279. <action application="set" data="default_language=en"/>
  280. <action application="set" data="callstart=2020-11-19 11:15:37"/>
  281. <action application="set" data="hangup_after_bridge=true"/>
  282. <action application="set" data="continue_on_fail=TRUE"/>
  283. <action application="set" data="account_id=67"/>
  284. <action application="set" data="parent_id=0"/>
  285. <action application="set" data="entity_id=0"/>
  286. <action application="set" data="call_processed=internal"/>
  287. <action application="set" data="call_direction=inbound"/>
  288. <action application="set" data="accountname=default"/>
  289. <action application="set" data="filename1=astpp.pbx.lua"/>
  290. <action application="set" data="origination_rates_did=ID:25|CODE:^0110720229.*|DESTINATION:TORINO TO|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:94|ACCID:49"/>
  291. <action application="set" data="origination_rates=0"/>
  292. <action application="set" data="original_caller_id_name=511"/>
  293. <action application="set" data="original_caller_id_number=01119217873"/>
  294. <action application="limit" data="db 49 user_49 4 !SWITCH_CONGESTION"/>
  295. <action application="set" data="effective_caller_id_name=511"/>
  296. <action application="set" data="effective_caller_id_number=01119217873"/>
  297. <action application="set" data="receiver_accid=49"/>
  298. <action application="export" data="domain_name=cta.conexopbx.it"/>
  299. <action application="export" data="sip_to_host=cta.conexopbx.it"/>
  300. <action application="limit" data="db 0110720229 did_0110720229 4 !SWITCH_CONGESTION"/>
  301. <action application="export" data="presence_data=x|||testnikunj3(790604)|||^0110720229.* // TORINO TO // 0.00000||||||DID|||117.247.91.162"/>
  302. <action application="export" data="call_type=10"/>
  303. <action application="set" data="did_calltype=10"/>
  304. <action application="set" data="did_extensions=11"/>
  305. <action application="set" data="ringback="/>
  306. <action application="set" data="module_name=pbx"/>
  307. <action application="set" data="sip_h_P-call_type=custom_forward"/>
  308. <action application="set" data="sip_h_P-Accountcode=49"/>
  309. <action application="set" data="no_answer_number=3"/>
  310. <action application="export" data="no_answer_number=3"/>
  311. <action application="set" data="no_answer_call_type=ringgroup"/>
  312. <action application="set" data="no_answer_call_type_value=3"/>
  313. <action application="set" data="opensips_flag=0"/>
  314. <action application="set" data="originate_disposition=no_key_press"/>
  315. <action application="set" data="variable_sip_to_host=cta.conexopbx.it"/>
  316. <action application="set" data="userinfo_id=67"/>
  317. <action application="set" data="variable_sip_to_host=cta.conexopbx.it"/>
  318. <action application="set" data="original_did_number=0110720229"/>
  319.     <action application="answer"/>
  320. <action application="ivr" data="apertura-ita31"/>
  321. <action application="lua" data="astpp/lib/pbx/astpp-failover_ivr_destination.lua"/>
  322. </condition>
  323. </extension>
  324. </context>
  325. </section>
  326. </document>
  327. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it parsing [default->0110720229] continue=false
  328. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Regex (PASS) [0110720229] destination_number(0110720229) =~ /0110720229/ break=on-false
  329. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(effective_destination_number=0110720229)
  330. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(bridge_pre_execute_bleg_app=sched_hangup)
  331. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
  332. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(default_language=en)
  333. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(callstart=2020-11-19 11:15:37)
  334. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(hangup_after_bridge=true)
  335. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(continue_on_fail=TRUE)
  336. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(account_id=67)
  337. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(parent_id=0)
  338. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(entity_id=0)
  339. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(call_processed=internal)
  340. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(call_direction=inbound)
  341. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(accountname=default)
  342. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(filename1=astpp.pbx.lua)
  343. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(origination_rates_did=ID:25|CODE:^0110720229.*|DESTINATION:TORINO TO|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:94|ACCID:49)
  344. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(origination_rates=0)
  345. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(original_caller_id_name=511)
  346. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(original_caller_id_number=01119217873)
  347. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action limit(db 49 user_49 4 !SWITCH_CONGESTION)
  348. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(effective_caller_id_name=511)
  349. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(effective_caller_id_number=01119217873)
  350. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(receiver_accid=49)
  351. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action export(domain_name=cta.conexopbx.it)
  352. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action export(sip_to_host=cta.conexopbx.it)
  353. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action limit(db 0110720229 did_0110720229 4 !SWITCH_CONGESTION)
  354. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action export(presence_data=x|||testnikunj3(790604)|||^0110720229.* // TORINO TO // 0.00000||||||DID|||117.247.91.162)
  355. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action export(call_type=10)
  356. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(did_calltype=10)
  357. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(did_extensions=11)
  358. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(ringback=)
  359. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(module_name=pbx)
  360. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(sip_h_P-call_type=custom_forward)
  361. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(sip_h_P-Accountcode=49)
  362. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(no_answer_number=3)
  363. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action export(no_answer_number=3)
  364. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(no_answer_call_type=ringgroup)
  365. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(no_answer_call_type_value=3)
  366. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(opensips_flag=0)
  367. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(originate_disposition=no_key_press)
  368. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(variable_sip_to_host=cta.conexopbx.it)
  369. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(userinfo_id=67)
  370. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(variable_sip_to_host=cta.conexopbx.it)
  371. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action set(original_did_number=0110720229)
  372. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action answer()
  373. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action ivr(apertura-ita31)
  374. Dialplan: sofia/default/511@testnikunj340.netgen.conexopbx.it Action lua(astpp/lib/pbx/astpp-failover_ivr_destination.lua)
  375. 2020-11-19 12:15:37.834904 [DEBUG] switch_core_state_machine.c:287 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State Change CS_ROUTING -> CS_EXECUTE
  376. 2020-11-19 12:15:37.834904 [DEBUG] switch_core_state_machine.c:644 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State ROUTING going to sleep
  377. 2020-11-19 12:15:37.834904 [DEBUG] switch_core_state_machine.c:585 (sofia/default/511@testnikunj340.netgen.conexopbx.it) Running State Change CS_EXECUTE (Cur 3 Tot 1982)
  378. 2020-11-19 12:15:37.834904 [DEBUG] switch_core_state_machine.c:651 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State EXECUTE
  379. 2020-11-19 12:15:37.834904 [DEBUG] mod_sofia.c:209 sofia/default/511@testnikunj340.netgen.conexopbx.it SOFIA EXECUTE
  380. 2020-11-19 12:15:37.834904 [DEBUG] switch_core_state_machine.c:329 sofia/default/511@testnikunj340.netgen.conexopbx.it Standard EXECUTE
  381. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(effective_destination_number=0110720229)
  382. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [effective_destination_number]=[0110720229]
  383. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(bridge_pre_execute_bleg_app=sched_hangup)
  384. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [bridge_pre_execute_bleg_app]=[sched_hangup]
  385. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
  386. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [bridge_pre_execute_bleg_data]=[+6000 normal_clearing]
  387. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(default_language=en)
  388. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [default_language]=[en]
  389. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(callstart=2020-11-19 11:15:37)
  390. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [callstart]=[2020-11-19 11:15:37]
  391. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(hangup_after_bridge=true)
  392. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [hangup_after_bridge]=[true]
  393. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(continue_on_fail=TRUE)
  394. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [continue_on_fail]=[TRUE]
  395. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(account_id=67)
  396. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [account_id]=[67]
  397. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(parent_id=0)
  398. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [parent_id]=[0]
  399. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(entity_id=0)
  400. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [entity_id]=[0]
  401. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(call_processed=internal)
  402. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [call_processed]=[internal]
  403. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(call_direction=inbound)
  404. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [call_direction]=[inbound]
  405. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(accountname=default)
  406. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [accountname]=[default]
  407. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(filename1=astpp.pbx.lua)
  408. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [filename1]=[astpp.pbx.lua]
  409. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(origination_rates_did=ID:25|CODE:^0110720229.*|DESTINATION:TORINO TO|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:94|ACCID:49)
  410. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [origination_rates_did]=[ID:25|CODE:^0110720229.*|DESTINATION:TORINO TO|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:94|ACCID:49]
  411. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(origination_rates=0)
  412. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [origination_rates]=[0]
  413. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(original_caller_id_name=511)
  414. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [original_caller_id_name]=[511]
  415. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(original_caller_id_number=01119217873)
  416. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [original_caller_id_number]=[01119217873]
  417. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it limit(db 49 user_49 4 !SWITCH_CONGESTION)
  418. 2020-11-19 12:15:37.834904 [DEBUG] switch_limit.c:124 incr called: 49_user_49 max:4, interval:0
  419. 2020-11-19 12:15:37.834904 [DEBUG] mod_db.c:194 Usage for 49_user_49 is now 1/4
  420. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(effective_caller_id_name=511)
  421. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [effective_caller_id_name]=[511]
  422. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(effective_caller_id_number=01119217873)
  423. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [effective_caller_id_number]=[01119217873]
  424. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(receiver_accid=49)
  425. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [receiver_accid]=[49]
  426. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it export(domain_name=cta.conexopbx.it)
  427. 2020-11-19 12:15:37.834904 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [domain_name]=[cta.conexopbx.it]
  428. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it export(sip_to_host=cta.conexopbx.it)
  429. 2020-11-19 12:15:37.834904 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [sip_to_host]=[cta.conexopbx.it]
  430. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it limit(db 0110720229 did_0110720229 4 !SWITCH_CONGESTION)
  431. 2020-11-19 12:15:37.834904 [DEBUG] switch_limit.c:124 incr called: 0110720229_did_0110720229 max:4, interval:0
  432. 2020-11-19 12:15:37.834904 [DEBUG] mod_db.c:194 Usage for 0110720229_did_0110720229 is now 1/4
  433. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it export(presence_data=x|||testnikunj3(790604)|||^0110720229.* // TORINO TO // 0.00000||||||DID|||117.247.91.162)
  434. 2020-11-19 12:15:37.834904 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [presence_data]=[x|||testnikunj3(790604)|||^0110720229.* // TORINO TO // 0.00000||||||DID|||117.247.91.162]
  435. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it export(call_type=10)
  436. 2020-11-19 12:15:37.834904 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_type]=[10]
  437. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(did_calltype=10)
  438. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [did_calltype]=[10]
  439. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(did_extensions=11)
  440. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [did_extensions]=[11]
  441. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(ringback=)
  442. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [ringback]=[UNDEF]
  443. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(module_name=pbx)
  444. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [module_name]=[pbx]
  445. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(sip_h_P-call_type=custom_forward)
  446. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [sip_h_P-call_type]=[custom_forward]
  447. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(sip_h_P-Accountcode=49)
  448. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [sip_h_P-Accountcode]=[49]
  449. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(no_answer_number=3)
  450. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [no_answer_number]=[3]
  451. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it export(no_answer_number=3)
  452. 2020-11-19 12:15:37.834904 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [no_answer_number]=[3]
  453. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(no_answer_call_type=ringgroup)
  454. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [no_answer_call_type]=[ringgroup]
  455. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(no_answer_call_type_value=3)
  456. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [no_answer_call_type_value]=[3]
  457. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(opensips_flag=0)
  458. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [opensips_flag]=[0]
  459. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(originate_disposition=no_key_press)
  460. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [originate_disposition]=[no_key_press]
  461. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(variable_sip_to_host=cta.conexopbx.it)
  462. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [variable_sip_to_host]=[cta.conexopbx.it]
  463. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(userinfo_id=67)
  464. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [userinfo_id]=[67]
  465. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(variable_sip_to_host=cta.conexopbx.it)
  466. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [variable_sip_to_host]=[cta.conexopbx.it]
  467. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it set(original_did_number=0110720229)
  468. 2020-11-19 12:15:37.834904 [DEBUG] mod_dptools.c:1672 SET sofia/default/511@testnikunj340.netgen.conexopbx.it [original_did_number]=[0110720229]
  469. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it answer()
  470. 2020-11-19 12:15:37.834904 [DEBUG] switch_core_media.c:8663 AUDIO RTP [sofia/default/511@testnikunj340.netgen.conexopbx.it] 212.97.34.173 port 24478 -> 117.247.91.162 port 8000 codec: 8 ms: 20
  471. 2020-11-19 12:15:37.834904 [DEBUG] switch_rtp.c:4450 Starting timer [soft] 160 bytes per 20ms
  472. 2020-11-19 12:15:37.834904 [DEBUG] switch_core_media.c:8977 sofia/default/511@testnikunj340.netgen.conexopbx.it Set 2833 dtmf send payload to 101
  473. 2020-11-19 12:15:37.834904 [DEBUG] switch_core_media.c:8984 sofia/default/511@testnikunj340.netgen.conexopbx.it Set 2833 dtmf receive payload to 101
  474. 2020-11-19 12:15:37.834904 [DEBUG] switch_core_media.c:9007 sofia/default/511@testnikunj340.netgen.conexopbx.it Set rtp dtmf delay to 40
  475. 2020-11-19 12:15:37.834904 [DEBUG] mod_sofia.c:898 Local SDP sofia/default/511@testnikunj340.netgen.conexopbx.it:
  476. v=0
  477. o=FreeSWITCH 1605760059 1605760060 IN IP4 212.97.34.173
  478. s=FreeSWITCH
  479. c=IN IP4 212.97.34.173
  480. t=0 0
  481. m=audio 24478 RTP/AVP 8 101
  482. a=rtpmap:8 PCMA/8000
  483. a=rtpmap:101 telephone-event/8000
  484. a=fmtp:101 0-16
  485. a=ptime:20
  486. a=sendrecv
  487.  
  488. 2020-11-19 12:15:37.834904 [NOTICE] mod_dptools.c:1406 Channel [sofia/default/511@testnikunj340.netgen.conexopbx.it] has been answered
  489. 2020-11-19 12:15:37.834904 [DEBUG] switch_channel.c:3865 (sofia/default/511@testnikunj340.netgen.conexopbx.it) Callstate Change RINGING -> ACTIVE
  490. 2020-11-19 12:15:37.834904 [DEBUG] sofia.c:7326 Channel sofia/default/511@testnikunj340.netgen.conexopbx.it entering state [completed][200]
  491. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it ivr(apertura-ita31)
  492. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-exit'
  493. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-sub'
  494. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-exec-app'
  495. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-play-sound'
  496. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-back'
  497. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-top'
  498. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:883 building menu 'apertura-ita31'
  499. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '1'
  500. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '2'
  501. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '3'
  502. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '4'
  503. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '5'
  504. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '6'
  505. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '7'
  506. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '/^(\d{2,20})$/'
  507. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_menu.c:486 Executing IVR menu apertura-ita31
  508. 2020-11-19 12:15:37.874909 [DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@8000hz 1 channels 20ms
  509. 2020-11-19 12:15:41.414909 [DEBUG] sofia.c:7326 Channel sofia/default/511@testnikunj340.netgen.conexopbx.it entering state [ready][200]
  510. 2020-11-19 12:15:41.694907 [INFO] switch_rtp.c:7719 Auto Changing audio port from 117.247.91.162:8000 to 117.247.91.162:2728
  511. 2020-11-19 12:15:47.874907 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 5:960
  512. 2020-11-19 12:15:47.874907 [INFO] switch_channel.c:522 RECV DTMF 5:960
  513. 2020-11-19 12:15:47.874907 [DEBUG] switch_ivr_play_say.c:1933 done playing file /var/www/html/astpp/upload/pbx/ivr-ita_250920031049.wav
  514. 2020-11-19 12:15:47.874907 [DEBUG] switch_ivr_menu.c:378 waiting for 19/20 digits t/o 2000
  515. 2020-11-19 12:15:49.894908 [DEBUG] switch_ivr_menu.c:425 digits '5'
  516. 2020-11-19 12:15:49.894908 [DEBUG] switch_ivr_menu.c:580 IVR action on menu 'apertura-ita31' matched '5' param 'bridge {absolute_codec_string=^^:PCMA:PCMU:G729,ignore_early_media=true,sip_h_P-call_type='custom_forward',sip_h_P-Accountcode=49}[call_timeout=0,group_confirm_key=exec,group_confirm_file=lua /usr/local/freeswitch/scripts/astpp/lib/astpp.confirm.lua,confirm=true,announcement=no_file,dialed_user=503,leg_timeout=0,leg_delay_start=25]sofia/${sofia_profile_name}/503@${domain_name}|'
  517. 2020-11-19 12:15:49.894908 [DEBUG] switch_ivr_menu.c:584 switch_ivr_menu_execute todo=[2]
  518. EXECUTE [depth=0] sofia/default/511@testnikunj340.netgen.conexopbx.it bridge({absolute_codec_string=^^:PCMA:PCMU:G729,ignore_early_media=true,sip_h_P-call_type='custom_forward',sip_h_P-Accountcode=49}[call_timeout=0,group_confirm_key=exec,group_confirm_file=lua /usr/local/freeswitch/scripts/astpp/lib/astpp.confirm.lua,confirm=true,announcement=no_file,dialed_user=503,leg_timeout=0,leg_delay_start=25]sofia/default/503@cta.conexopbx.it|)
  519. 2020-11-19 12:15:49.894908 [DEBUG] switch_channel.c:1906 (sofia/default/511@testnikunj340.netgen.conexopbx.it) Callstate Change ACTIVE -> RING_WAIT
  520. 2020-11-19 12:15:49.894908 [DEBUG] switch_channel.c:1264 sofia/default/511@testnikunj340.netgen.conexopbx.it EXPORTING[export_vars] [domain_name]=[cta.conexopbx.it] to event
  521. 2020-11-19 12:15:49.894908 [DEBUG] switch_channel.c:1264 sofia/default/511@testnikunj340.netgen.conexopbx.it EXPORTING[export_vars] [sip_to_host]=[cta.conexopbx.it] to event
  522. 2020-11-19 12:15:49.894908 [DEBUG] switch_channel.c:1264 sofia/default/511@testnikunj340.netgen.conexopbx.it EXPORTING[export_vars] [presence_data]=[x|||testnikunj3(790604)|||^0110720229.* // TORINO TO // 0.00000||||||DID|||117.247.91.162] to event
  523. 2020-11-19 12:15:49.894908 [DEBUG] switch_channel.c:1264 sofia/default/511@testnikunj340.netgen.conexopbx.it EXPORTING[export_vars] [call_type]=[10] to event
  524. 2020-11-19 12:15:49.894908 [DEBUG] switch_channel.c:1264 sofia/default/511@testnikunj340.netgen.conexopbx.it EXPORTING[export_vars] [no_answer_number]=[3] to event
  525. 2020-11-19 12:15:49.894908 [DEBUG] switch_ivr_originate.c:2242 Parsing global variables
  526. 2020-11-19 12:15:49.894908 [DEBUG] switch_ivr_originate.c:2804 Parsing session specific variables
  527. 2020-11-19 12:15:49.894908 [NOTICE] switch_channel.c:1118 New Channel sofia/default/503@cta.conexopbx.it [06e26508-8f64-4cc5-8ed8-d07490e49353]
  528. 2020-11-19 12:15:49.894908 [DEBUG] mod_sofia.c:5089 (sofia/default/503@cta.conexopbx.it) State Change CS_NEW -> CS_INIT
  529. 2020-11-19 12:15:49.894908 [DEBUG] switch_ivr_originate.c:3129 sofia/default/503@cta.conexopbx.it Setting leg delay start to 25
  530. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:585 (sofia/default/503@cta.conexopbx.it) Running State Change CS_INIT (Cur 4 Tot 1983)
  531. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:628 (sofia/default/503@cta.conexopbx.it) State INIT
  532. 2020-11-19 12:15:49.894908 [DEBUG] mod_sofia.c:93 sofia/default/503@cta.conexopbx.it SOFIA INIT
  533. 2020-11-19 12:15:49.894908 [DEBUG] sofia_glue.c:1618 sofia/default/503@cta.conexopbx.it sending invite version: 1.10.5 -release.8 64bit
  534. Local SDP:
  535. v=0
  536. o=FreeSWITCH 1605767657 1605767658 IN IP4 212.97.34.173
  537. s=FreeSWITCH
  538. c=IN IP4 212.97.34.173
  539. t=0 0
  540. m=audio 16892 RTP/AVP 8 0 18 101
  541. a=rtpmap:8 PCMA/8000
  542. a=rtpmap:0 PCMU/8000
  543. a=rtpmap:18 G729/8000
  544. a=fmtp:18 annexb=no
  545. a=rtpmap:101 telephone-event/8000
  546. a=fmtp:101 0-16
  547. a=ptime:20
  548. a=sendrecv
  549.  
  550. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:40 sofia/default/503@cta.conexopbx.it Standard INIT
  551. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:48 (sofia/default/503@cta.conexopbx.it) State Change CS_INIT -> CS_ROUTING
  552. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:628 (sofia/default/503@cta.conexopbx.it) State INIT going to sleep
  553. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:585 (sofia/default/503@cta.conexopbx.it) Running State Change CS_ROUTING (Cur 4 Tot 1983)
  554. 2020-11-19 12:15:49.894908 [DEBUG] sofia.c:7326 Channel sofia/default/503@cta.conexopbx.it entering state [calling][0]
  555. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:644 (sofia/default/503@cta.conexopbx.it) State ROUTING
  556. 2020-11-19 12:15:49.894908 [DEBUG] mod_sofia.c:154 sofia/default/503@cta.conexopbx.it SOFIA ROUTING
  557. 2020-11-19 12:15:49.894908 [DEBUG] switch_ivr_originate.c:67 (sofia/default/503@cta.conexopbx.it) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  558. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:644 (sofia/default/503@cta.conexopbx.it) State ROUTING going to sleep
  559. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:585 (sofia/default/503@cta.conexopbx.it) Running State Change CS_CONSUME_MEDIA (Cur 4 Tot 1983)
  560. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:663 (sofia/default/503@cta.conexopbx.it) State CONSUME_MEDIA
  561. 2020-11-19 12:15:49.894908 [DEBUG] switch_core_state_machine.c:663 (sofia/default/503@cta.conexopbx.it) State CONSUME_MEDIA going to sleep
  562. 2020-11-19 12:15:50.034916 [NOTICE] switch_channel.c:1118 New Channel sofia/default/01119217873@212.97.34.173 [9c2f0338-7067-4267-be08-d8d2a1dcc130]
  563. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_state_machine.c:585 (sofia/default/01119217873@212.97.34.173) Running State Change CS_NEW (Cur 5 Tot 1984)
  564. 2020-11-19 12:15:50.034916 [DEBUG] sofia.c:10280 sofia/default/01119217873@212.97.34.173 receiving invite from 212.97.34.174:5060 version: 1.10.5 -release.8 64bit
  565. 2020-11-19 12:15:50.034916 [DEBUG] sofia.c:10374 verifying acl "default" for ip/port 212.97.34.174:0.
  566. 2020-11-19 12:15:50.034916 [DEBUG] sofia.c:10403 IP 212.97.34.174 Approved by acl "default[]". Access Granted.
  567. 2020-11-19 12:15:50.034916 [DEBUG] sofia.c:7326 Channel sofia/default/01119217873@212.97.34.173 entering state [received][100]
  568. 2020-11-19 12:15:50.034916 [DEBUG] sofia.c:7336 Remote SDP:
  569. v=0
  570. o=FreeSWITCH 1605767657 1605767658 IN IP4 212.97.34.173
  571. s=FreeSWITCH
  572. c=IN IP4 212.97.34.173
  573. t=0 0
  574. m=audio 16892 RTP/AVP 8 0 18 101
  575. a=rtpmap:8 PCMA/8000
  576. a=rtpmap:0 PCMU/8000
  577. a=rtpmap:18 G729/8000
  578. a=fmtp:18 annexb=no
  579. a=rtpmap:101 telephone-event/8000
  580. a=fmtp:101 0-16
  581. a=ptime:20
  582.  
  583. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  584. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  585. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  586. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  587. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  588. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  589. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  590. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  591. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  592. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  593. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
  594. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
  595. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5510 Set telephone-event payload to 101@8000
  596. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:3839 Set Codec sofia/default/01119217873@212.97.34.173 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  597. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_codec.c:111 sofia/default/01119217873@212.97.34.173 Original read codec set to PCMA:8
  598. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5853 Set telephone-event payload to 101@8000
  599. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_media.c:5911 sofia/default/01119217873@212.97.34.173 Set 2833 dtmf send payload to 101 recv payload to 101
  600. 2020-11-19 12:15:50.034916 [DEBUG] sofia.c:7760 (sofia/default/01119217873@212.97.34.173) State Change CS_NEW -> CS_INIT
  601. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_state_machine.c:604 (sofia/default/01119217873@212.97.34.173) State NEW
  602. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_state_machine.c:585 (sofia/default/01119217873@212.97.34.173) Running State Change CS_INIT (Cur 5 Tot 1984)
  603. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_state_machine.c:628 (sofia/default/01119217873@212.97.34.173) State INIT
  604. 2020-11-19 12:15:50.034916 [DEBUG] mod_sofia.c:93 sofia/default/01119217873@212.97.34.173 SOFIA INIT
  605. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_state_machine.c:40 sofia/default/01119217873@212.97.34.173 Standard INIT
  606. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_state_machine.c:48 (sofia/default/01119217873@212.97.34.173) State Change CS_INIT -> CS_ROUTING
  607. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_state_machine.c:628 (sofia/default/01119217873@212.97.34.173) State INIT going to sleep
  608. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_state_machine.c:585 (sofia/default/01119217873@212.97.34.173) Running State Change CS_ROUTING (Cur 5 Tot 1984)
  609. 2020-11-19 12:15:50.034916 [DEBUG] switch_channel.c:2332 (sofia/default/01119217873@212.97.34.173) Callstate Change DOWN -> RINGING
  610. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_state_machine.c:644 (sofia/default/01119217873@212.97.34.173) State ROUTING
  611. 2020-11-19 12:15:50.034916 [DEBUG] mod_sofia.c:154 sofia/default/01119217873@212.97.34.173 SOFIA ROUTING
  612. 2020-11-19 12:15:50.034916 [DEBUG] switch_core_state_machine.c:236 sofia/default/01119217873@212.97.34.173 Standard ROUTING
  613. 2020-11-19 12:15:50.034916 [INFO] mod_dialplan_xml.c:637 Processing 511 <01119217873>->503 in context default
  614. 2020-11-19 12:15:50.034916 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
  615. 2020-11-19 12:15:50.034916 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  616. 2020-11-19 12:15:50.054904 [NOTICE] switch_cpp.cpp:1447 [ASTPP] [xml_handler] Params:
  617. Event-Name: REQUEST_PARAMS
  618. Core-UUID: 7a529bf8-00e7-433b-92b6-35586a85dc31
  619. FreeSWITCH-Hostname: pbx2.conexo.tech
  620. FreeSWITCH-Switchname: pbx2.conexo.tech
  621. FreeSWITCH-IPv4: 212.97.34.173
  622. FreeSWITCH-IPv6: %3A%3A1
  623. Event-Date-Local: 2020-11-19%2012%3A15%3A50
  624. Event-Date-GMT: Thu,%2019%20Nov%202020%2011%3A15%3A50%20GMT
  625. Event-Date-Timestamp: 1605784550034916
  626. Event-Calling-File: mod_dialplan_xml.c
  627. Event-Calling-Function: dialplan_xml_locate
  628. Event-Calling-Line-Number: 608
  629. Event-Sequence: 215086
  630. Channel-State: CS_ROUTING
  631. Channel-Call-State: RINGING
  632. Channel-State-Number: 2
  633. Channel-Name: sofia/default/01119217873%40212.97.34.173
  634. Unique-ID: 9c2f0338-7067-4267-be08-d8d2a1dcc130
  635. Call-Direction: inbound
  636. Presence-Call-Direction: inbound
  637. Channel-HIT-Dialplan: true
  638. Channel-Presence-ID: 01119217873%40212.97.34.173
  639. Channel-Call-UUID: 9c2f0338-7067-4267-be08-d8d2a1dcc130
  640. Answer-State: ringing
  641. Channel-Read-Codec-Name: PCMA
  642. Channel-Read-Codec-Rate: 8000
  643. Channel-Read-Codec-Bit-Rate: 64000
  644. Channel-Write-Codec-Name: PCMA
  645. Channel-Write-Codec-Rate: 8000
  646. Channel-Write-Codec-Bit-Rate: 64000
  647. Caller-Direction: inbound
  648. Caller-Logical-Direction: inbound
  649. Caller-Username: 01119217873
  650. Caller-Dialplan: XML
  651. Caller-Caller-ID-Name: 511
  652. Caller-Caller-ID-Number: 01119217873
  653. Caller-Orig-Caller-ID-Name: 511
  654. Caller-Orig-Caller-ID-Number: 01119217873
  655. Caller-Network-Addr: 212.97.34.174
  656. Caller-ANI: 01119217873
  657. Caller-Destination-Number: 503
  658. Caller-Unique-ID: 9c2f0338-7067-4267-be08-d8d2a1dcc130
  659. Caller-Source: mod_sofia
  660. Caller-Context: default
  661. Caller-Channel-Name: sofia/default/01119217873%40212.97.34.173
  662. Caller-Profile-Index: 1
  663. Caller-Profile-Created-Time: 1605784550034916
  664. Caller-Channel-Created-Time: 1605784550034916
  665. Caller-Channel-Answered-Time: 0
  666. Caller-Channel-Progress-Time: 0
  667. Caller-Channel-Progress-Media-Time: 0
  668. Caller-Channel-Hangup-Time: 0
  669. Caller-Channel-Transfer-Time: 0
  670. Caller-Channel-Resurrect-Time: 0
  671. Caller-Channel-Bridged-Time: 0
  672. Caller-Channel-Last-Hold: 0
  673. Caller-Channel-Hold-Accum: 0
  674. Caller-Screen-Bit: true
  675. Caller-Privacy-Hide-Name: false
  676. Caller-Privacy-Hide-Number: false
  677. variable_direction: inbound
  678. variable_uuid: 9c2f0338-7067-4267-be08-d8d2a1dcc130
  679. variable_session_id: 1984
  680. variable_sip_from_user: 01119217873
  681. variable_sip_from_uri: 01119217873%40212.97.34.173
  682. variable_sip_from_host: 212.97.34.173
  683. variable_video_media_flow: disabled
  684. variable_text_media_flow: disabled
  685. variable_channel_name: sofia/default/01119217873%40212.97.34.173
  686. variable_sip_call_id: 6bb50f8d-a4fb-1239-4790-0050561a2d8e
  687. variable_sip_local_network_addr: 212.97.34.173
  688. variable_sip_network_ip: 212.97.34.174
  689. variable_sip_network_port: 5060
  690. variable_sip_invite_stamp: 1605784550034916
  691. variable_sip_received_ip: 212.97.34.174
  692. variable_sip_received_port: 5060
  693. variable_sip_via_protocol: udp
  694. variable_sip_authorized: true
  695. variable_sip_acl_authed_by: default
  696. variable_sip_from_user_stripped: 01119217873
  697. variable_sip_from_tag: mtHFt08r2pygj
  698. variable_sofia_profile_name: default
  699. variable_sofia_profile_url: sip%3Amod_sofia%40212.97.34.173%3A7777
  700. variable_recovery_profile_name: default
  701. variable_sip_Remote-Party-ID: %22511%22%20%3Csip%3A01119217873%40212.97.34.173%3E%3Bparty%3Dcalling%3Bscreen%3Dyes%3Bprivacy%3Doff
  702. variable_sip_cid_type: rpid
  703. variable_sip_invite_route_uri: %3Csip%3A212.97.34.174%3Blr%3Bdid%3D81c.7e8ad4e6%3E,%3Csip%3A212.97.34.174%3Blr%3Bdid%3D81c.6e8ad4e6%3E
  704. variable_sip_invite_record_route: %3Csip%3A212.97.34.174%3Blr%3Bdid%3D81c.6e8ad4e6%3E,%3Csip%3A212.97.34.174%3Blr%3Bdid%3D81c.7e8ad4e6%3E
  705. variable_sip_full_via: SIP/2.0/UDP%20212.97.34.174%3A5060%3Bbranch%3Dz9hG4bK6557.3b42cad6.0,SIP/2.0/UDP%20212.97.34.174%3A5060%3Bbranch%3Dz9hG4bK6557.2b42cad6.0,SIP/2.0/UDP%20212.97.34.173%3A7777%3Breceived%3D212.97.34.173%3Brport%3D7777%3Bbranch%3Dz9hG4bKv212B43eU1cDH
  706. variable_sip_from_display: 511
  707. variable_sip_full_from: %22511%22%20%3Csip%3A01119217873%40212.97.34.173%3E%3Btag%3DmtHFt08r2pygj
  708. variable_sip_full_to: %3Csip%3A503%40cta.conexopbx.it%3E
  709. variable_sip_allow: INVITE,%20ACK,%20BYE,%20CANCEL,%20OPTIONS,%20MESSAGE,%20INFO,%20UPDATE,%20REGISTER,%20REFER,%20NOTIFY,%20PUBLISH,%20SUBSCRIBE
  710. variable_sip_req_user: 503
  711. variable_sip_req_uri: 503%40cta.conexopbx.it
  712. variable_sip_req_host: cta.conexopbx.it
  713. variable_sip_to_user: 503
  714. variable_sip_to_uri: 503%40cta.conexopbx.it
  715. variable_sip_to_host: cta.conexopbx.it
  716. variable_sip_contact_user: mod_sofia
  717. variable_sip_contact_port: 7777
  718. variable_sip_contact_uri: mod_sofia%40212.97.34.173%3A7777
  719. variable_sip_contact_host: 212.97.34.173
  720. variable_sip_user_agent: ASTPP
  721. variable_sip_via_host: 212.97.34.174
  722. variable_sip_via_port: 5060
  723. variable_max_forwards: 27
  724. variable_presence_id: 01119217873%40212.97.34.173
  725. variable_sip_h_P-call_type: custom_forward
  726. variable_sip_h_X-AUTH-IP: 212.97.34.174
  727. variable_sip_h_P-Accountcode: 449093
  728. variable_sip_h_P-effective_caller_id_name: 01119217873
  729. variable_sip_h_P-effective_caller_id_number: 01119217873
  730. variable_switch_r_sdp: v%3D0%0D%0Ao%3DFreeSWITCH%201605767657%201605767658%20IN%20IP4%20212.97.34.173%0D%0As%3DFreeSWITCH%0D%0Ac%3DIN%20IP4%20212.97.34.173%0D%0At%3D0%200%0D%0Am%3Daudio%2016892%20RTP/AVP%208%200%2018%20101%0D%0Aa%3Drtpmap%3A8%20PCMA/8000%0D%0Aa%3Drtpmap%3A0%20PCMU/8000%0D%0Aa%3Drtpmap%3A18%20G729/8000%0D%0Aa%3Dfmtp%3A18%20annexb%3Dno%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-16%0D%0Aa%3Dptime%3A20%0D%0A
  731. variable_ep_codec_string: CORE_PCM_MODULE.PCMA%408000h%4020i%4064000b,CORE_PCM_MODULE.PCMU%408000h%4020i%4064000b,mod_bcg729.G729%408000h%4020i%408000b
  732. variable_rtp_use_codec_string: PCMA,PCMU,G729
  733. variable_remote_video_media_flow: inactive
  734. variable_remote_text_media_flow: inactive
  735. variable_remote_audio_media_flow: sendrecv
  736. variable_audio_media_flow: sendrecv
  737. variable_remote_media_ip: 212.97.34.173
  738. variable_remote_media_port: 16892
  739. variable_rtp_audio_recv_pt: 8
  740. variable_rtp_use_codec_name: PCMA
  741. variable_rtp_use_codec_rate: 8000
  742. variable_rtp_use_codec_ptime: 20
  743. variable_rtp_use_codec_channels: 1
  744. variable_rtp_last_audio_codec_string: PCMA%408000h%4020i%401c
  745. variable_read_codec: PCMA
  746. variable_original_read_codec: PCMA
  747. variable_read_rate: 8000
  748. variable_original_read_rate: 8000
  749. variable_write_codec: PCMA
  750. variable_write_rate: 8000
  751. variable_dtmf_type: rfc2833
  752. variable_endpoint_disposition: RECEIVED
  753. variable_call_uuid: 9c2f0338-7067-4267-be08-d8d2a1dcc130
  754. Hunt-Direction: inbound
  755. Hunt-Logical-Direction: inbound
  756. Hunt-Username: 01119217873
  757. Hunt-Dialplan: XML
  758. Hunt-Caller-ID-Name: 511
  759. Hunt-Caller-ID-Number: 01119217873
  760. Hunt-Orig-Caller-ID-Name: 511
  761. Hunt-Orig-Caller-ID-Number: 01119217873
  762. Hunt-Network-Addr: 212.97.34.174
  763. Hunt-ANI: 01119217873
  764. Hunt-Destination-Number: 503
  765. Hunt-Unique-ID: 9c2f0338-7067-4267-be08-d8d2a1dcc130
  766. Hunt-Source: mod_sofia
  767. Hunt-Context: default
  768. Hunt-Channel-Name: sofia/default/01119217873%40212.97.34.173
  769. Hunt-Profile-Index: 1
  770. Hunt-Profile-Created-Time: 1605784550034916
  771. Hunt-Channel-Created-Time: 1605784550034916
  772. Hunt-Channel-Answered-Time: 0
  773. Hunt-Channel-Progress-Time: 0
  774. Hunt-Channel-Progress-Media-Time: 0
  775. Hunt-Channel-Hangup-Time: 0
  776. Hunt-Channel-Transfer-Time: 0
  777. Hunt-Channel-Resurrect-Time: 0
  778. Hunt-Channel-Bridged-Time: 0
  779. Hunt-Channel-Last-Hold: 0
  780. Hunt-Channel-Hold-Accum: 0
  781. Hunt-Screen-Bit: true
  782. Hunt-Privacy-Hide-Name: false
  783. Hunt-Privacy-Hide-Number: false
  784.  
  785.  
  786. 2020-11-19 12:15:50.054904 [INFO] switch_cpp.cpp:1447 [ASTPP] [xml_REQUEST] key_name:
  787. 2020-11-19 12:15:50.054904 [INFO] switch_cpp.cpp:1447 [ASTPP] [xml_REQUEST] key_value:
  788. 2020-11-19 12:15:50.054904 [INFO] switch_cpp.cpp:1447 [ASTPP] [xml_REQUEST] tag_name:
  789. 2020-11-19 12:15:50.054904 [INFO] switch_cpp.cpp:1447 [ASTPP] [xml_REQUEST] section: dialplan
  790. 2020-11-19 12:15:50.054904 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] blind_flag: 0
  791. 2020-11-19 12:15:50.054904 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] Dialed number : 503
  792. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '503' limit 1
  793. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '503' AND status=0 limit 1
  794. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '503' and status=0 LIMIT 1
  795. 2020-11-19 12:15:50.054904 [INFO] switch_cpp.cpp:1447 [ASTPP] SOURCE NUMBERmod_sofia
  796. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION LOCAL SOURCE] Query :SELECT domain,accountid FROM domains WHERE domain = 'cta.conexopbx.it' limit 1
  797. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION LOCAL DOMAIN] Query :SELECT accountid from sip_devices where accountid = '49' and username = '503' limit 1
  798. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION LOCAL] Query :SELECT local_effective_caller_id_name,local_effective_caller_id_number FROM sip_devices WHERE username = 'mod_sofia' limit 1
  799. 2020-11-19 12:15:50.054904 [WARNING] switch_cpp.cpp:1447 [ASTPP] [FAXER] in custom Caller ID
  800. 2020-11-19 12:15:50.054904 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] Caller Id name / number  : 511 / 01119217873
  801. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET domains] Query :SELECT * FROM domains WHERE accountid = 449093 limit 1
  802. 2020-11-19 12:15:50.054904 [NOTICE] switch_cpp.cpp:1447 [ASTPP] DID global translation id: 3
  803. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 3 AND status=0 limit 1
  804. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET_LOCALIZATION] Query :"+39/*".....503
  805. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [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 ="503" LIMIT 1
  806. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [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="503"  AND domains.domain="cta.conexopbx.it" limit 1
  807. 2020-11-19 12:15:50.054904 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] Call direction : local
  808. 2020-11-19 12:15:50.054904 [INFO] switch_cpp.cpp:1447 [ASTPP] [Accountcode1212 : 449093]
  809. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [GET get_acc_info] Query :SELECT count(id) as id FROM local_number WHERE number =503
  810. 2020-11-19 12:15:50.054904 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE id = "449093" AND deleted = 0 limit 1
  811. 2020-11-19 12:15:50.054904 [WARNING] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION] [449093] Account is either Deactive/Expire or deleted..!!
  812. 2020-11-19 12:15:50.054904 [ERR] mod_lua.cpp:202 /usr/share/freeswitch/scripts/astpp/lib/astpp.functions.lua:96: attempt to concatenate local 'accountid' (a nil value)
  813. stack traceback:
  814.         /usr/share/freeswitch/scripts/astpp/lib/astpp.functions.lua:96: in function 'get_speeddial_number'
  815.         /usr/share/freeswitch/scripts/astpp/scripts/astpp.dialplan.lua:252: in main chunk
  816.         [C]: in function 'dofile'
  817.         /usr/share/freeswitch/scripts/astpp/astpp.lua:86: in main chunk
  818. 2020-11-19 12:15:50.054904 [ERR] mod_lua.cpp:270 LUA script parse/execute error!
  819. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->unloop] continue=false
  820. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  821. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  822. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->tod_example] continue=true
  823. Dialplan: sofia/default/01119217873@212.97.34.173 Date/Time Match (PASS) [tod_example] break=on-false
  824. Dialplan: sofia/default/01119217873@212.97.34.173 Action set(open=true)
  825. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->holiday_example] continue=true
  826. Dialplan: sofia/default/01119217873@212.97.34.173 Date/TimeMatch (FAIL) [holiday_example] break=on-false
  827. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->global-intercept] continue=false
  828. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [global-intercept] destination_number(503) =~ /^886$/ break=on-false
  829. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->group-intercept] continue=false
  830. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [group-intercept] destination_number(503) =~ /^\*8$/ break=on-false
  831. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->intercept-ext] continue=false
  832. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [intercept-ext] destination_number(503) =~ /^\*\*(\d+)$/ break=on-false
  833. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->redial] continue=false
  834. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [redial] destination_number(503) =~ /^(redial|870)$/ break=on-false
  835. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->global] continue=true
  836. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
  837. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (PASS) [global] ${default_password}(1234) =~ /^1234$/ break=never
  838. Dialplan: sofia/default/01119217873@212.97.34.173 Action log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING )
  839. Dialplan: sofia/default/01119217873@212.97.34.173 Action log(CRIT Open /etc/freeswitch/vars.xml and change the default_password.)
  840. Dialplan: sofia/default/01119217873@212.97.34.173 Action log(CRIT Once changed type 'reloadxml' at the console.)
  841. Dialplan: sofia/default/01119217873@212.97.34.173 Action log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING )
  842. Dialplan: sofia/default/01119217873@212.97.34.173 Action sleep(10000)
  843. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never
  844. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [global] ${endpoint_disposition}(RECEIVED) =~ /^(DELAYED NEGOTIATION)/ break=on-false
  845. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->snom-demo-2] continue=false
  846. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [snom-demo-2] destination_number(503) =~ /^9001$/ break=on-false
  847. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->snom-demo-1] continue=false
  848. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [snom-demo-1] destination_number(503) =~ /^9000$/ break=on-false
  849. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->eavesdrop] continue=false
  850. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [eavesdrop] destination_number(503) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
  851. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->eavesdrop] continue=false
  852. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [eavesdrop] destination_number(503) =~ /^779$/ break=on-false
  853. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->call_return] continue=false
  854. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [call_return] destination_number(503) =~ /^\*69$|^869$|^lcr$/ break=on-false
  855. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->del-group] continue=false
  856. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [del-group] destination_number(503) =~ /^80(\d{2})$/ break=on-false
  857. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->add-group] continue=false
  858. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [add-group] destination_number(503) =~ /^81(\d{2})$/ break=on-false
  859. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->call-group-simo] continue=false
  860. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [call-group-simo] destination_number(503) =~ /^82(\d{2})$/ break=on-false
  861. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->call-group-order] continue=false
  862. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [call-group-order] destination_number(503) =~ /^83(\d{2})$/ break=on-false
  863. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->extension-intercom] continue=false
  864. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [extension-intercom] destination_number(503) =~ /^8(10[01][0-9])$/ break=on-false
  865. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->Local_Extension] continue=false
  866. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [Local_Extension] destination_number(503) =~ /^(10[01][0-9])$/ break=on-false
  867. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->Local_Extension_Skinny] continue=false
  868. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [Local_Extension_Skinny] destination_number(503) =~ /^(11[01][0-9])$/ break=on-false
  869. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->group_dial_sales] continue=false
  870. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [group_dial_sales] destination_number(503) =~ /^2000$/ break=on-false
  871. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->group_dial_support] continue=false
  872. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [group_dial_support] destination_number(503) =~ /^2001$/ break=on-false
  873. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->group_dial_billing] continue=false
  874. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [group_dial_billing] destination_number(503) =~ /^2002$/ break=on-false
  875. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->operator] continue=false
  876. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [operator] destination_number(503) =~ /^(operator|0)$/ break=on-false
  877. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->vmain] continue=false
  878. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [vmain] destination_number(503) =~ /^vmain$|^4000$|^\*98$/ break=on-false
  879. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->sip_uri] continue=false
  880. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [sip_uri] destination_number(503) =~ /^sip:(.*)$/ break=on-false
  881. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->nb_conferences] continue=false
  882. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [nb_conferences] destination_number(503) =~ /^(30\d{2})$/ break=on-false
  883. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->wb_conferences] continue=false
  884. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [wb_conferences] destination_number(503) =~ /^(31\d{2})$/ break=on-false
  885. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->uwb_conferences] continue=false
  886. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [uwb_conferences] destination_number(503) =~ /^(32\d{2})$/ break=on-false
  887. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->cdquality_conferences] continue=false
  888. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [cdquality_conferences] destination_number(503) =~ /^(33\d{2})$/ break=on-false
  889. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->cdquality_stereo_conferences] continue=false
  890. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [cdquality_stereo_conferences] destination_number(503) =~ /^(35\d{2}).*?-screen$/ break=on-false
  891. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->conference-canvases] continue=true
  892. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [conference-canvases] destination_number(503) =~ /(35\d{2})-canvas-(\d+)/ break=on-false
  893. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->conf mod] continue=false
  894. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [conf mod] destination_number(503) =~ /^6070-moderator$/ break=on-false
  895. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->cdquality_conferences] continue=false
  896. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [cdquality_conferences] destination_number(503) =~ /^(35\d{2})$/ break=on-false
  897. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->cdquality_conferences_720] continue=false
  898. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [cdquality_conferences_720] destination_number(503) =~ /^(36\d{2})$/ break=on-false
  899. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->cdquality_conferences_480] continue=false
  900. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [cdquality_conferences_480] destination_number(503) =~ /^(37\d{2})$/ break=on-false
  901. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->cdquality_conferences_320] continue=false
  902. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [cdquality_conferences_320] destination_number(503) =~ /^(38\d{2})$/ break=on-false
  903. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->freeswitch_public_conf_via_sip] continue=false
  904. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [freeswitch_public_conf_via_sip] destination_number(503) =~ /^9(888|8888|1616|3232)$/ break=on-false
  905. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->mad_boss_intercom] continue=false
  906. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [mad_boss_intercom] destination_number(503) =~ /^0911$/ break=on-false
  907. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->mad_boss_intercom] continue=false
  908. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [mad_boss_intercom] destination_number(503) =~ /^0912$/ break=on-false
  909. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->mad_boss] continue=false
  910. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [mad_boss] destination_number(503) =~ /^0913$/ break=on-false
  911. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->ivr_demo] continue=false
  912. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [ivr_demo] destination_number(503) =~ /^5000$/ break=on-false
  913. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->dynamic_conference] continue=false
  914. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [dynamic_conference] destination_number(503) =~ /^5001$/ break=on-false
  915. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->rtp_multicast_page] continue=false
  916. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [rtp_multicast_page] destination_number(503) =~ /^pagegroup$|^7243$/ break=on-false
  917. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->park] continue=false
  918. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [park] destination_number(503) =~ /^5900$/ break=on-false
  919. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->unpark] continue=false
  920. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [unpark] destination_number(503) =~ /^5901$/ break=on-false
  921. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->valet_park] continue=false
  922. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [valet_park] destination_number(503) =~ /^(6000)$/ break=on-false
  923. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->valet_park] continue=false
  924. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [valet_park] destination_number(503) =~ /^((?!6000)60\d{2})$/ break=on-false
  925. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->park] continue=false
  926. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false
  927. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [park] destination_number(503) =~ /park\+(\d+)/ break=on-false
  928. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->unpark] continue=false
  929. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false
  930. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [unpark] destination_number(503) =~ /^parking$/ break=on-false
  931. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->park] continue=false
  932. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false
  933. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [park] destination_number(503) =~ /callpark/ break=on-false
  934. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->unpark] continue=false
  935. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false
  936. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [unpark] destination_number(503) =~ /pickup/ break=on-false
  937. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->wait] continue=false
  938. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [wait] destination_number(503) =~ /^wait$/ break=on-false
  939. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->fax_receive] continue=false
  940. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [fax_receive] destination_number(503) =~ /^9178$/ break=on-false
  941. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->fax_transmit] continue=false
  942. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [fax_transmit] destination_number(503) =~ /^9179$/ break=on-false
  943. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->ringback_180] continue=false
  944. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [ringback_180] destination_number(503) =~ /^9180$/ break=on-false
  945. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->ringback_183_uk_ring] continue=false
  946. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [ringback_183_uk_ring] destination_number(503) =~ /^9181$/ break=on-false
  947. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->ringback_183_music_ring] continue=false
  948. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [ringback_183_music_ring] destination_number(503) =~ /^9182$/ break=on-false
  949. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->ringback_post_answer_uk_ring] continue=false
  950. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [ringback_post_answer_uk_ring] destination_number(503) =~ /^9183$/ break=on-false
  951. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->ringback_post_answer_music] continue=false
  952. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [ringback_post_answer_music] destination_number(503) =~ /^9184$/ break=on-false
  953. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->ClueCon] continue=false
  954. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [ClueCon] destination_number(503) =~ /^9191$/ break=on-false
  955. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->show_info] continue=false
  956. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [show_info] destination_number(503) =~ /^9192$/ break=on-false
  957. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->video_record] continue=false
  958. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [video_record] destination_number(503) =~ /^9193$/ break=on-false
  959. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->video_playback] continue=false
  960. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [video_playback] destination_number(503) =~ /^9194$/ break=on-false
  961. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->delay_echo] continue=false
  962. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [delay_echo] destination_number(503) =~ /^9195$/ break=on-false
  963. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->echo] continue=false
  964. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [echo] destination_number(503) =~ /^9196$/ break=on-false
  965. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->milliwatt] continue=false
  966. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [milliwatt] destination_number(503) =~ /^9197$/ break=on-false
  967. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->tone_stream] continue=false
  968. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [tone_stream] destination_number(503) =~ /^9198$/ break=on-false
  969. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->zrtp_enrollement] continue=false
  970. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [zrtp_enrollement] destination_number(503) =~ /^9787$/ break=on-false
  971. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->hold_music] continue=false
  972. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [hold_music] destination_number(503) =~ /^9664$/ break=on-false
  973. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->laugh break] continue=false
  974. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [laugh break] destination_number(503) =~ /^9386$/ break=on-false
  975. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->101] continue=false
  976. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [101] destination_number(503) =~ /^101$/ break=on-false
  977. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->pizza_demo] continue=false
  978. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [pizza_demo] destination_number(503) =~ /^(pizza|74992)$/ break=on-false
  979. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->Talking Clock Time] continue=false
  980. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [Talking Clock Time] destination_number(503) =~ /^9170$/ break=on-false
  981. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->Talking Clock Date] continue=false
  982. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [Talking Clock Date] destination_number(503) =~ /^9171$/ break=on-false
  983. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->Talking Clock Date and Time] continue=false
  984. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [Talking Clock Date and Time] destination_number(503) =~ /^9172$/ break=on-false
  985. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->local.example.com] continue=false
  986. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [local.example.com] ${toll_allow}() =~ /local/ break=on-false
  987. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->domestic.example.com] continue=false
  988. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [domestic.example.com] ${toll_allow}() =~ /domestic/ break=on-false
  989. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->international.example.com] continue=false
  990. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [international.example.com] ${toll_allow}() =~ /international/ break=on-false
  991. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->enum] continue=false
  992. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (FAIL) [enum] ${module_exists(mod_enum)}(false) =~ /true/ break=on-false
  993. Dialplan: sofia/default/01119217873@212.97.34.173 parsing [default->acknowledge_call] continue=false
  994. Dialplan: sofia/default/01119217873@212.97.34.173 Regex (PASS) [acknowledge_call] destination_number(503) =~ /^(.*)$/ break=on-false
  995. Dialplan: sofia/default/01119217873@212.97.34.173 Action acknowledge_call()
  996. Dialplan: sofia/default/01119217873@212.97.34.173 Action ring_ready()
  997. Dialplan: sofia/default/01119217873@212.97.34.173 Action playback(local_stream://moh)
  998. 2020-11-19 12:15:50.074911 [DEBUG] switch_core_state_machine.c:287 (sofia/default/01119217873@212.97.34.173) State Change CS_ROUTING -> CS_EXECUTE
  999. 2020-11-19 12:15:50.074911 [DEBUG] switch_core_state_machine.c:644 (sofia/default/01119217873@212.97.34.173) State ROUTING going to sleep
  1000. 2020-11-19 12:15:50.074911 [DEBUG] switch_core_state_machine.c:585 (sofia/default/01119217873@212.97.34.173) Running State Change CS_EXECUTE (Cur 5 Tot 1984)
  1001. 2020-11-19 12:15:50.074911 [DEBUG] switch_core_state_machine.c:651 (sofia/default/01119217873@212.97.34.173) State EXECUTE
  1002. 2020-11-19 12:15:50.074911 [DEBUG] mod_sofia.c:209 sofia/default/01119217873@212.97.34.173 SOFIA EXECUTE
  1003. 2020-11-19 12:15:50.074911 [DEBUG] switch_core_state_machine.c:329 sofia/default/01119217873@212.97.34.173 Standard EXECUTE
  1004. EXECUTE [depth=0] sofia/default/01119217873@212.97.34.173 set(open=true)
  1005. 2020-11-19 12:15:50.074911 [DEBUG] mod_dptools.c:1672 SET sofia/default/01119217873@212.97.34.173 [open]=[true]
  1006. EXECUTE [depth=0] sofia/default/01119217873@212.97.34.173 log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING )
  1007. 2020-11-19 12:15:50.074911 [CRIT] mod_dptools.c:1866 WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING
  1008. EXECUTE [depth=0] sofia/default/01119217873@212.97.34.173 log(CRIT Open /etc/freeswitch/vars.xml and change the default_password.)
  1009. 2020-11-19 12:15:50.074911 [CRIT] mod_dptools.c:1866 Open /etc/freeswitch/vars.xml and change the default_password.
  1010. EXECUTE [depth=0] sofia/default/01119217873@212.97.34.173 log(CRIT Once changed type 'reloadxml' at the console.)
  1011. 2020-11-19 12:15:50.074911 [CRIT] mod_dptools.c:1866 Once changed type 'reloadxml' at the console.
  1012. EXECUTE [depth=0] sofia/default/01119217873@212.97.34.173 log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING )
  1013. 2020-11-19 12:15:50.074911 [CRIT] mod_dptools.c:1866 WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING
  1014. EXECUTE [depth=0] sofia/default/01119217873@212.97.34.173 sleep(10000)
  1015. EXECUTE [depth=0] sofia/default/01119217873@212.97.34.173 acknowledge_call()
  1016. EXECUTE [depth=0] sofia/default/01119217873@212.97.34.173 ring_ready()
  1017. 2020-11-19 12:16:00.114905 [NOTICE] mod_sofia.c:2498 Ring-Ready sofia/default/01119217873@212.97.34.173!
  1018. 2020-11-19 12:16:00.114905 [DEBUG] sofia.c:7326 Channel sofia/default/01119217873@212.97.34.173 entering state [early][180]
  1019. 2020-11-19 12:16:00.114905 [NOTICE] mod_dptools.c:1122 Ring Ready sofia/default/01119217873@212.97.34.173!
  1020. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_session.c:2722 Application playback Requires media! pre_answering channel sofia/default/01119217873@212.97.34.173
  1021. 2020-11-19 12:16:00.114905 [INFO] switch_core_session.c:2724 Sending early media
  1022. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:8663 AUDIO RTP [sofia/default/01119217873@212.97.34.173] 212.97.34.173 port 25312 -> 212.97.34.173 port 16892 codec: 8 ms: 20
  1023. 2020-11-19 12:16:00.114905 [DEBUG] switch_rtp.c:4450 Starting timer [soft] 160 bytes per 20ms
  1024. 2020-11-19 12:16:00.114905 [DEBUG] sofia.c:7326 Channel sofia/default/503@cta.conexopbx.it entering state [proceeding][180]
  1025. 2020-11-19 12:16:00.114905 [NOTICE] sofia.c:7437 Ring-Ready sofia/default/503@cta.conexopbx.it!
  1026. 2020-11-19 12:16:00.114905 [DEBUG] switch_channel.c:3437 (sofia/default/503@cta.conexopbx.it) Callstate Change DOWN -> RINGING
  1027. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:8977 sofia/default/01119217873@212.97.34.173 Set 2833 dtmf send payload to 101
  1028. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:8984 sofia/default/01119217873@212.97.34.173 Set 2833 dtmf receive payload to 101
  1029. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:9007 sofia/default/01119217873@212.97.34.173 Set rtp dtmf delay to 40
  1030. 2020-11-19 12:16:00.114905 [DEBUG] mod_sofia.c:2593 Ring SDP:
  1031. v=0
  1032. o=FreeSWITCH 1605759248 1605759249 IN IP4 212.97.34.173
  1033. s=FreeSWITCH
  1034. c=IN IP4 212.97.34.173
  1035. t=0 0
  1036. m=audio 25312 RTP/AVP 8 101
  1037. a=rtpmap:8 PCMA/8000
  1038. a=rtpmap:101 telephone-event/8000
  1039. a=fmtp:101 0-16
  1040. a=ptime:20
  1041. a=sendrecv
  1042.  
  1043. 2020-11-19 12:16:00.114905 [NOTICE] mod_sofia.c:2596 Pre-Answer sofia/default/01119217873@212.97.34.173!
  1044. 2020-11-19 12:16:00.114905 [DEBUG] switch_channel.c:3565 (sofia/default/01119217873@212.97.34.173) Callstate Change RINGING -> EARLY
  1045. EXECUTE [depth=0] sofia/default/01119217873@212.97.34.173 playback(local_stream://moh)
  1046. 2020-11-19 12:16:00.114905 [DEBUG] mod_local_stream.c:909 Opening Stream [moh/8000] 8000hz
  1047. 2020-11-19 12:16:00.114905 [DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@8000hz 1 channels 20ms
  1048. 2020-11-19 12:16:00.114905 [DEBUG] sofia.c:7326 Channel sofia/default/01119217873@212.97.34.173 entering state [early][183]
  1049. 2020-11-19 12:16:00.114905 [DEBUG] sofia.c:7326 Channel sofia/default/503@cta.conexopbx.it entering state [proceeding][183]
  1050. 2020-11-19 12:16:00.114905 [DEBUG] sofia.c:7336 Remote SDP:
  1051. v=0
  1052. o=FreeSWITCH 1605759248 1605759249 IN IP4 212.97.34.173
  1053. s=FreeSWITCH
  1054. c=IN IP4 212.97.34.173
  1055. t=0 0
  1056. m=audio 25312 RTP/AVP 8 101
  1057. a=rtpmap:8 PCMA/8000
  1058. a=rtpmap:101 telephone-event/8000
  1059. a=fmtp:101 0-16
  1060. a=ptime:20
  1061.  
  1062. 2020-11-19 12:16:00.114905 [NOTICE] sofia.c:7339 Pre-Answer sofia/default/503@cta.conexopbx.it!
  1063. 2020-11-19 12:16:00.114905 [DEBUG] switch_channel.c:3565 (sofia/default/503@cta.conexopbx.it) Callstate Change RINGING -> EARLY
  1064. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  1065. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  1066. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  1067. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  1068. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:5510 Set telephone-event payload to 101@8000
  1069. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:3839 Set Codec sofia/default/503@cta.conexopbx.it PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  1070. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_codec.c:111 sofia/default/503@cta.conexopbx.it Original read codec set to PCMA:8
  1071. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:5853 Set telephone-event payload to 101@8000
  1072. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:5911 sofia/default/503@cta.conexopbx.it Set 2833 dtmf send payload to 101 recv payload to 101
  1073. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:8663 AUDIO RTP [sofia/default/503@cta.conexopbx.it] 212.97.34.173 port 16892 -> 212.97.34.173 port 25312 codec: 8 ms: 20
  1074. 2020-11-19 12:16:00.114905 [DEBUG] switch_rtp.c:4450 Starting timer [soft] 160 bytes per 20ms
  1075. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:8977 sofia/default/503@cta.conexopbx.it Set 2833 dtmf send payload to 101
  1076. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:8984 sofia/default/503@cta.conexopbx.it Set 2833 dtmf receive payload to 101
  1077. 2020-11-19 12:16:00.114905 [DEBUG] switch_core_media.c:9007 sofia/default/503@cta.conexopbx.it Set rtp dtmf delay to 40
  1078. 2020-11-19 12:16:03.874904 [NOTICE] sofia.c:1089 Hangup sofia/default/511@testnikunj340.netgen.conexopbx.it [CS_EXECUTE] [NORMAL_CLEARING]
  1079. 2020-11-19 12:16:03.874904 [NOTICE] switch_ivr_originate.c:3759 Hangup sofia/default/503@cta.conexopbx.it [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
  1080. 2020-11-19 12:16:03.874904 [DEBUG] switch_ivr_originate.c:3984 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
  1081. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:585 (sofia/default/503@cta.conexopbx.it) Running State Change CS_HANGUP (Cur 5 Tot 1984)
  1082. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:848 (sofia/default/503@cta.conexopbx.it) Callstate Change EARLY -> HANGUP
  1083. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:850 (sofia/default/503@cta.conexopbx.it) State HANGUP
  1084. 2020-11-19 12:16:03.874904 [DEBUG] mod_sofia.c:447 sofia/default/503@cta.conexopbx.it Overriding SIP cause 487 with 200 from the other leg
  1085. 2020-11-19 12:16:03.874904 [DEBUG] mod_sofia.c:453 Channel sofia/default/503@cta.conexopbx.it hanging up, cause: ORIGINATOR_CANCEL
  1086. 2020-11-19 12:16:03.874904 [INFO] mod_dptools.c:3631 Originate Failed.  Cause: ORIGINATOR_CANCEL
  1087. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_session.c:2905 sofia/default/511@testnikunj340.netgen.conexopbx.it skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1088. 2020-11-19 12:16:03.874904 [DEBUG] switch_ivr_menu.c:562 action regex [5] [/^(\d{2,20})$/] [0]
  1089. 2020-11-19 12:16:03.874904 [DEBUG] switch_ivr_menu.c:676 exit-sound '(null)'
  1090. 2020-11-19 12:16:03.874904 [DEBUG] mod_sofia.c:521 Sending CANCEL to sofia/default/503@cta.conexopbx.it
  1091. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:60 sofia/default/503@cta.conexopbx.it Standard HANGUP, cause: ORIGINATOR_CANCEL
  1092. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_session.c:2905 sofia/default/511@testnikunj340.netgen.conexopbx.it skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1093. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:850 (sofia/default/503@cta.conexopbx.it) State HANGUP going to sleep
  1094. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:651 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State EXECUTE going to sleep
  1095. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:585 (sofia/default/511@testnikunj340.netgen.conexopbx.it) Running State Change CS_HANGUP (Cur 5 Tot 1984)
  1096. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:620 (sofia/default/503@cta.conexopbx.it) State Change CS_HANGUP -> CS_REPORTING
  1097. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:585 (sofia/default/503@cta.conexopbx.it) Running State Change CS_REPORTING (Cur 5 Tot 1984)
  1098. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:936 (sofia/default/503@cta.conexopbx.it) State REPORTING
  1099. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:848 (sofia/default/511@testnikunj340.netgen.conexopbx.it) Callstate Change RING_WAIT -> HANGUP
  1100. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:850 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State HANGUP
  1101. 2020-11-19 12:16:03.874904 [DEBUG] mod_sofia.c:453 Channel sofia/default/511@testnikunj340.netgen.conexopbx.it hanging up, cause: NORMAL_CLEARING
  1102. 2020-11-19 12:16:03.874904 [INFO] mod_json_cdr.c:271 Process [06e26508-8f64-4cc5-8ed8-d07490e49353.cdr.json]
  1103. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:60 sofia/default/511@testnikunj340.netgen.conexopbx.it Standard HANGUP, cause: NORMAL_CLEARING
  1104. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:850 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State HANGUP going to sleep
  1105. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:620 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State Change CS_HANGUP -> CS_REPORTING
  1106. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:585 (sofia/default/511@testnikunj340.netgen.conexopbx.it) Running State Change CS_REPORTING (Cur 5 Tot 1984)
  1107. 2020-11-19 12:16:03.874904 [DEBUG] switch_core_state_machine.c:936 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State REPORTING
  1108. 2020-11-19 12:16:03.874904 [INFO] mod_json_cdr.c:271 Process [a5b20031-4479-46c4-9197-aebd9b3d563d.cdr.json]
  1109. 2020-11-19 12:16:03.894905 [DEBUG] sofia.c:7326 Channel sofia/default/01119217873@212.97.34.173 entering state [terminated][487]
  1110. 2020-11-19 12:16:03.894905 [NOTICE] sofia.c:8559 Hangup sofia/default/01119217873@212.97.34.173 [CS_EXECUTE] [ORIGINATOR_CANCEL]
  1111. 2020-11-19 12:16:03.894905 [DEBUG] switch_ivr_play_say.c:1933 done playing file local_stream://moh
  1112. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_session.c:2905 sofia/default/01119217873@212.97.34.173 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1113. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:651 (sofia/default/01119217873@212.97.34.173) State EXECUTE going to sleep
  1114. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:585 (sofia/default/01119217873@212.97.34.173) Running State Change CS_HANGUP (Cur 5 Tot 1984)
  1115. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:848 (sofia/default/01119217873@212.97.34.173) Callstate Change EARLY -> HANGUP
  1116. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:850 (sofia/default/01119217873@212.97.34.173) State HANGUP
  1117. 2020-11-19 12:16:03.894905 [DEBUG] mod_sofia.c:453 Channel sofia/default/01119217873@212.97.34.173 hanging up, cause: ORIGINATOR_CANCEL
  1118. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:60 sofia/default/01119217873@212.97.34.173 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1119. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:850 (sofia/default/01119217873@212.97.34.173) State HANGUP going to sleep
  1120. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:620 (sofia/default/01119217873@212.97.34.173) State Change CS_HANGUP -> CS_REPORTING
  1121. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:585 (sofia/default/01119217873@212.97.34.173) Running State Change CS_REPORTING (Cur 5 Tot 1984)
  1122. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:936 (sofia/default/01119217873@212.97.34.173) State REPORTING
  1123. 2020-11-19 12:16:03.894905 [INFO] mod_json_cdr.c:271 Process [9c2f0338-7067-4267-be08-d8d2a1dcc130.cdr.json]
  1124. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:174 sofia/default/503@cta.conexopbx.it Standard REPORTING, cause: ORIGINATOR_CANCEL
  1125. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:936 (sofia/default/503@cta.conexopbx.it) State REPORTING going to sleep
  1126. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:611 (sofia/default/503@cta.conexopbx.it) State Change CS_REPORTING -> CS_DESTROY
  1127. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_session.c:1726 Session 1983 (sofia/default/503@cta.conexopbx.it) Locked, Waiting on external entities
  1128. 2020-11-19 12:16:03.894905 [NOTICE] switch_core_session.c:1744 Session 1983 (sofia/default/503@cta.conexopbx.it) Ended
  1129. 2020-11-19 12:16:03.894905 [NOTICE] switch_core_session.c:1748 Close Channel sofia/default/503@cta.conexopbx.it [CS_DESTROY]
  1130. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:739 (sofia/default/503@cta.conexopbx.it) Running State Change CS_DESTROY (Cur 4 Tot 1984)
  1131. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:749 (sofia/default/503@cta.conexopbx.it) State DESTROY
  1132. 2020-11-19 12:16:03.894905 [DEBUG] mod_sofia.c:364 sofia/default/503@cta.conexopbx.it SOFIA DESTROY
  1133. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:181 sofia/default/503@cta.conexopbx.it Standard DESTROY
  1134. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:749 (sofia/default/503@cta.conexopbx.it) State DESTROY going to sleep
  1135. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:174 sofia/default/01119217873@212.97.34.173 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1136. 2020-11-19 12:16:03.894905 [DEBUG] switch_core_state_machine.c:936 (sofia/default/01119217873@212.97.34.173) State REPORTING going to sleep
  1137. 2020-11-19 12:16:03.914912 [DEBUG] switch_core_state_machine.c:611 (sofia/default/01119217873@212.97.34.173) State Change CS_REPORTING -> CS_DESTROY
  1138. 2020-11-19 12:16:03.914912 [DEBUG] switch_core_session.c:1726 Session 1984 (sofia/default/01119217873@212.97.34.173) Locked, Waiting on external entities
  1139. 2020-11-19 12:16:03.914912 [NOTICE] switch_core_session.c:1744 Session 1984 (sofia/default/01119217873@212.97.34.173) Ended
  1140. 2020-11-19 12:16:03.914912 [NOTICE] switch_core_session.c:1748 Close Channel sofia/default/01119217873@212.97.34.173 [CS_DESTROY]
  1141. 2020-11-19 12:16:03.914912 [DEBUG] switch_core_state_machine.c:739 (sofia/default/01119217873@212.97.34.173) Running State Change CS_DESTROY (Cur 3 Tot 1984)
  1142. 2020-11-19 12:16:03.914912 [DEBUG] switch_core_state_machine.c:749 (sofia/default/01119217873@212.97.34.173) State DESTROY
  1143. 2020-11-19 12:16:03.914912 [DEBUG] mod_sofia.c:364 sofia/default/01119217873@212.97.34.173 SOFIA DESTROY
  1144. 2020-11-19 12:16:03.914912 [DEBUG] switch_core_state_machine.c:181 sofia/default/01119217873@212.97.34.173 Standard DESTROY
  1145. 2020-11-19 12:16:03.914912 [DEBUG] switch_core_state_machine.c:749 (sofia/default/01119217873@212.97.34.173) State DESTROY going to sleep
  1146. 2020-11-19 12:16:03.934912 [DEBUG] switch_core_state_machine.c:174 sofia/default/511@testnikunj340.netgen.conexopbx.it Standard REPORTING, cause: NORMAL_CLEARING
  1147. 2020-11-19 12:16:03.934912 [DEBUG] switch_core_state_machine.c:936 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State REPORTING going to sleep
  1148. 2020-11-19 12:16:03.934912 [DEBUG] switch_core_state_machine.c:611 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State Change CS_REPORTING -> CS_DESTROY
  1149. 2020-11-19 12:16:03.934912 [DEBUG] switch_core_session.c:1726 Session 1982 (sofia/default/511@testnikunj340.netgen.conexopbx.it) Locked, Waiting on external entities
  1150. 2020-11-19 12:16:03.934912 [NOTICE] switch_core_session.c:1744 Session 1982 (sofia/default/511@testnikunj340.netgen.conexopbx.it) Ended
  1151. 2020-11-19 12:16:03.934912 [NOTICE] switch_core_session.c:1748 Close Channel sofia/default/511@testnikunj340.netgen.conexopbx.it [CS_DESTROY]
  1152. 2020-11-19 12:16:03.934912 [DEBUG] switch_core_state_machine.c:739 (sofia/default/511@testnikunj340.netgen.conexopbx.it) Running State Change CS_DESTROY (Cur 2 Tot 1984)
  1153. 2020-11-19 12:16:03.934912 [DEBUG] switch_core_state_machine.c:749 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State DESTROY
  1154. 2020-11-19 12:16:03.934912 [DEBUG] mod_sofia.c:364 sofia/default/511@testnikunj340.netgen.conexopbx.it SOFIA DESTROY
  1155. 2020-11-19 12:16:03.934912 [DEBUG] switch_core_state_machine.c:181 sofia/default/511@testnikunj340.netgen.conexopbx.it Standard DESTROY
  1156. 2020-11-19 12:16:03.934912 [DEBUG] switch_core_state_machine.c:749 (sofia/default/511@testnikunj340.netgen.conexopbx.it) State DESTROY going to sleep
  1157. 2020-11-19 12:16:14.014904 [NOTICE] switch_ivr_originate.c:3759 Hangup sofia/default/390402332953 [CS_CONSUME_MEDIA] [NO_ANSWER]
  1158. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:585 (sofia/default/390402332953) Running State Change CS_HANGUP (Cur 2 Tot 1984)
  1159. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:848 (sofia/default/390402332953) Callstate Change RINGING -> HANGUP
  1160. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:850 (sofia/default/390402332953) State HANGUP
  1161. 2020-11-19 12:16:14.014904 [DEBUG] mod_sofia.c:453 Channel sofia/default/390402332953 hanging up, cause: NO_ANSWER
  1162. 2020-11-19 12:16:14.014904 [INFO] mod_dptools.c:3631 Originate Failed.  Cause: NO_ANSWER
  1163. 2020-11-19 12:16:14.014904 [INFO] mod_dptools.c:4905 immediately releasing
  1164. 2020-11-19 12:16:14.014904 [DEBUG] mod_sofia.c:521 Sending CANCEL to sofia/default/390402332953
  1165. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:60 sofia/default/390402332953 Standard HANGUP, cause: NO_ANSWER
  1166. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:850 (sofia/default/390402332953) State HANGUP going to sleep
  1167. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:620 (sofia/default/390402332953) State Change CS_HANGUP -> CS_REPORTING
  1168. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:585 (sofia/default/390402332953) Running State Change CS_REPORTING (Cur 2 Tot 1984)
  1169. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:936 (sofia/default/390402332953) State REPORTING
  1170. EXECUTE [depth=0] sofia/default/0110720221@anstel.conexopbx.it bridge([leg_timeout=0,absolute_codec_string=^^:PCMA:G729]sofia/gateway/Uno_Primary/390402332953;fs_path=sip:212.97.34.174:5060)
  1171. 2020-11-19 12:16:14.014904 [INFO] mod_json_cdr.c:271 Process [9f3d78a9-6d53-42fb-a602-b670350d4656.cdr.json]
  1172. 2020-11-19 12:16:14.014904 [DEBUG] switch_channel.c:1264 sofia/default/0110720221@anstel.conexopbx.it EXPORTING[export_vars] [presence_data]=[x//23|||ANSTEL_CUS(101001)|||^04.* // Italy Landline Phones // 0.01000 // trunk_id=0|||IRIDEOS // ^0.* // Italy Landline Phones // 0.00450 // trunk_id=3|||STD|||164.132.3.232] to event
  1173. 2020-11-19 12:16:14.014904 [DEBUG] switch_channel.c:1264 sofia/default/0110720221@anstel.conexopbx.it EXPORTING[export_vars] [presence_data]=[x//23|||ANSTEL_CUS(101001)|||^04.* // Italy Landline Phones // 0.01000 // trunk_id=0|||IRIDEOS // ^0.* // Italy Landline Phones // 0.00450 // trunk_id=3|||STD|||164.132.3.232] to event
  1174. 2020-11-19 12:16:14.014904 [DEBUG] switch_ivr_originate.c:2242 Parsing global variables
  1175. 2020-11-19 12:16:14.014904 [DEBUG] switch_ivr_originate.c:2804 Parsing session specific variables
  1176. 2020-11-19 12:16:14.014904 [NOTICE] switch_channel.c:1118 New Channel sofia/default/390402332953 [adb27703-85ae-402e-91c9-d5a1a843e874]
  1177. 2020-11-19 12:16:14.014904 [DEBUG] mod_sofia.c:5089 (sofia/default/390402332953) State Change CS_NEW -> CS_INIT
  1178. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:585 (sofia/default/390402332953) Running State Change CS_INIT (Cur 3 Tot 1985)
  1179. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:628 (sofia/default/390402332953) State INIT
  1180. 2020-11-19 12:16:14.014904 [DEBUG] mod_sofia.c:93 sofia/default/390402332953 SOFIA INIT
  1181. 2020-11-19 12:16:14.014904 [DEBUG] sofia_glue.c:1587 sip:192.168.250.10 Setting proxy route to sofia/default/390402332953
  1182. 2020-11-19 12:16:14.014904 [DEBUG] sofia_glue.c:1618 sofia/default/390402332953 sending invite version: 1.10.5 -release.8 64bit
  1183. Local SDP:
  1184. v=0
  1185. o=FreeSWITCH 1605762772 1605762773 IN IP4 212.97.34.173
  1186. s=FreeSWITCH
  1187. c=IN IP4 212.97.34.173
  1188. t=0 0
  1189. m=audio 21802 RTP/AVP 8 18 101
  1190. a=rtpmap:8 PCMA/8000
  1191. a=rtpmap:18 G729/8000
  1192. a=fmtp:18 annexb=no
  1193. a=rtpmap:101 telephone-event/8000
  1194. a=fmtp:101 0-16
  1195. a=ptime:20
  1196. a=sendrecv
  1197.  
  1198. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:40 sofia/default/390402332953 Standard INIT
  1199. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:48 (sofia/default/390402332953) State Change CS_INIT -> CS_ROUTING
  1200. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:628 (sofia/default/390402332953) State INIT going to sleep
  1201. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:585 (sofia/default/390402332953) Running State Change CS_ROUTING (Cur 3 Tot 1985)
  1202. 2020-11-19 12:16:14.014904 [DEBUG] sofia.c:7326 Channel sofia/default/390402332953 entering state [calling][0]
  1203. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:644 (sofia/default/390402332953) State ROUTING
  1204. 2020-11-19 12:16:14.014904 [DEBUG] mod_sofia.c:154 sofia/default/390402332953 SOFIA ROUTING
  1205. 2020-11-19 12:16:14.014904 [DEBUG] switch_ivr_originate.c:67 (sofia/default/390402332953) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  1206. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:644 (sofia/default/390402332953) State ROUTING going to sleep
  1207. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:585 (sofia/default/390402332953) Running State Change CS_CONSUME_MEDIA (Cur 3 Tot 1985)
  1208. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:663 (sofia/default/390402332953) State CONSUME_MEDIA
  1209. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:663 (sofia/default/390402332953) State CONSUME_MEDIA going to sleep
  1210. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:174 sofia/default/390402332953 Standard REPORTING, cause: NO_ANSWER
  1211. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:936 (sofia/default/390402332953) State REPORTING going to sleep
  1212. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:611 (sofia/default/390402332953) State Change CS_REPORTING -> CS_DESTROY
  1213. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_session.c:1726 Session 1981 (sofia/default/390402332953) Locked, Waiting on external entities
  1214. 2020-11-19 12:16:14.014904 [NOTICE] switch_core_session.c:1744 Session 1981 (sofia/default/390402332953) Ended
  1215. 2020-11-19 12:16:14.014904 [NOTICE] switch_core_session.c:1748 Close Channel sofia/default/390402332953 [CS_DESTROY]
  1216. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:739 (sofia/default/390402332953) Running State Change CS_DESTROY (Cur 2 Tot 1985)
  1217. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:749 (sofia/default/390402332953) State DESTROY
  1218. 2020-11-19 12:16:14.014904 [DEBUG] mod_sofia.c:364 sofia/default/390402332953 SOFIA DESTROY
  1219. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:181 sofia/default/390402332953 Standard DESTROY
  1220. 2020-11-19 12:16:14.014904 [DEBUG] switch_core_state_machine.c:749 (sofia/default/390402332953) State DESTROY going to sleep
  1221. 2020-11-19 12:16:16.154964 [DEBUG] sofia.c:7326 Channel sofia/default/390402332953 entering state [proceeding][180]
  1222. 2020-11-19 12:16:16.154964 [DEBUG] sofia.c:7336 Remote SDP:
  1223. v=0
  1224. o=- 1605784574 1605784574 IN IP4 213.204.30.54
  1225. s=-
  1226. c=IN IP4 213.204.30.54
  1227. t=0 0
  1228. m=audio 4932 RTP/AVP 8 18 101
  1229. a=rtpmap:8 PCMA/8000
  1230. a=rtpmap:18 G729/8000
  1231. a=fmtp:18 annexb=no
  1232. a=rtpmap:101 telephone-event/8000
  1233. a=fmtp:101 0-15
  1234. a=ptime:20
  1235. a=silenceSupp:off - - - -
  1236.  
  1237. 2020-11-19 12:16:16.154964 [NOTICE] sofia.c:7339 Pre-Answer sofia/default/390402332953!
  1238. 2020-11-19 12:16:16.154964 [DEBUG] switch_channel.c:3565 (sofia/default/390402332953) Callstate Change DOWN -> EARLY
  1239. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  1240. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  1241. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  1242. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  1243. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
  1244. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
  1245. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:5510 Set telephone-event payload to 101@8000
  1246. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:3839 Set Codec sofia/default/390402332953 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  1247. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_codec.c:111 sofia/default/390402332953 Original read codec set to PCMA:8
  1248. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:5853 Set telephone-event payload to 101@8000
  1249. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:5911 sofia/default/390402332953 Set 2833 dtmf send payload to 101 recv payload to 101
  1250. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:8663 AUDIO RTP [sofia/default/390402332953] 212.97.34.173 port 21802 -> 213.204.30.54 port 4932 codec: 8 ms: 20
  1251. 2020-11-19 12:16:16.154964 [DEBUG] switch_rtp.c:4450 Starting timer [soft] 160 bytes per 20ms
  1252. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:8977 sofia/default/390402332953 Set 2833 dtmf send payload to 101
  1253. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:8984 sofia/default/390402332953 Set 2833 dtmf receive payload to 101
  1254. 2020-11-19 12:16:16.154964 [DEBUG] switch_core_media.c:9007 sofia/default/390402332953 Set rtp dtmf delay to 40
  1255. 2020-11-19 12:16:16.194903 [INFO] switch_ivr_originate.c:3801 Sending early media
  1256. 2020-11-19 12:16:16.194903 [DEBUG] switch_core_media.c:8663 AUDIO RTP [sofia/default/0110720221@anstel.conexopbx.it] 212.97.34.173 port 27738 -> 164.132.3.232 port 19226 codec: 0 ms: 20
  1257. 2020-11-19 12:16:16.194903 [DEBUG] switch_rtp.c:4450 Starting timer [soft] 160 bytes per 20ms
  1258. 2020-11-19 12:16:16.194903 [DEBUG] switch_core_media.c:8977 sofia/default/0110720221@anstel.conexopbx.it Set 2833 dtmf send payload to 101
  1259. 2020-11-19 12:16:16.194903 [DEBUG] switch_core_media.c:8984 sofia/default/0110720221@anstel.conexopbx.it Set 2833 dtmf receive payload to 101
  1260. 2020-11-19 12:16:16.194903 [DEBUG] switch_core_media.c:9007 sofia/default/0110720221@anstel.conexopbx.it Set rtp dtmf delay to 40
  1261. 2020-11-19 12:16:16.194903 [DEBUG] mod_sofia.c:2593 Ring SDP:
  1262. v=0
  1263. o=FreeSWITCH 1605756838 1605756839 IN IP4 212.97.34.173
  1264. s=FreeSWITCH
  1265. c=IN IP4 212.97.34.173
  1266. t=0 0
  1267. m=audio 27738 RTP/AVP 0 101
  1268. a=rtpmap:0 PCMU/8000
  1269. a=rtpmap:101 telephone-event/8000
  1270. a=fmtp:101 0-16
  1271. a=ptime:20
  1272. a=sendrecv
  1273.  
  1274. 2020-11-19 12:16:16.194903 [NOTICE] mod_sofia.c:2596 Pre-Answer sofia/default/0110720221@anstel.conexopbx.it!
  1275. 2020-11-19 12:16:16.194903 [DEBUG] switch_channel.c:3565 (sofia/default/0110720221@anstel.conexopbx.it) Callstate Change RINGING -> EARLY
  1276. 2020-11-19 12:16:16.194903 [DEBUG] switch_ivr_originate.c:3852 Originate Resulted in Success: [sofia/default/390402332953]
  1277. 2020-11-19 12:16:16.194903 [DEBUG] sofia.c:7326 Channel sofia/default/0110720221@anstel.conexopbx.it entering state [early][183]
  1278. 2020-11-19 12:16:16.194903 [DEBUG] switch_ivr_bridge.c:1793 (sofia/default/390402332953) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  1279. 2020-11-19 12:16:16.194903 [DEBUG] switch_core_state_machine.c:585 (sofia/default/390402332953) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 1985)
  1280. 2020-11-19 12:16:16.194903 [DEBUG] switch_core_state_machine.c:654 (sofia/default/390402332953) State EXCHANGE_MEDIA
  1281. 2020-11-19 12:16:16.194903 [DEBUG] mod_sofia.c:656 SOFIA EXCHANGE_MEDIA
  1282. 2020-11-19 12:16:16.234908 [DEBUG] switch_rtp.c:7759 Correct audio ip/port confirmed.
  1283. 2020-11-19 12:16:16.334899 [DEBUG] switch_rtp.c:7759 Correct audio ip/port confirmed.
  1284. 2020-11-19 12:16:16.374902 [DEBUG] switch_ivr_bridge.c:655 sofia/default/390402332953 Bridge execute app sched_hangup(+6000000000 normal_clearing)
  1285. 2020-11-19 12:16:16.394902 [DEBUG] switch_ivr.c:632 sofia/default/390402332953 Command Execute [depth=0] sched_hangup(+6000000000 normal_clearing)
  1286. EXECUTE [depth=0] sofia/default/390402332953 sched_hangup(+6000000000 normal_clearing)
  1287. 2020-11-19 12:16:16.394902 [DEBUG] switch_scheduler.c:252 Added task 665 switch_ivr_schedule_hangup (adb27703-85ae-402e-91c9-d5a1a843e874) to run at 3310817280
  1288. 2020-11-19 12:17:00.134922 [DEBUG] sofia.c:7326 Channel sofia/default/0110720221@anstel.conexopbx.it entering state [terminated][487]
  1289. 2020-11-19 12:17:00.134922 [NOTICE] sofia.c:8559 Hangup sofia/default/0110720221@anstel.conexopbx.it [CS_EXECUTE] [ORIGINATOR_CANCEL]
  1290. 2020-11-19 12:17:00.134922 [DEBUG] mod_hash.c:296 Usage for CPS_101001_CPS_user_101001 is now 0
  1291. 2020-11-19 12:17:00.134922 [DEBUG] mod_hash.c:296 Usage for CPS_101000_CPS_user_101000 is now 0
  1292. 2020-11-19 12:17:00.134922 [DEBUG] switch_ivr_bridge.c:826 sofia/default/0110720221@anstel.conexopbx.it ending bridge by request from read function
  1293. 2020-11-19 12:17:00.134922 [DEBUG] switch_ivr_bridge.c:912 BRIDGE THREAD DONE [sofia/default/0110720221@anstel.conexopbx.it]
  1294. 2020-11-19 12:17:00.134922 [DEBUG] switch_ivr_bridge.c:820 sofia/default/0110720221@anstel.conexopbx.it ending bridge by request from write function
  1295. 2020-11-19 12:17:00.134922 [DEBUG] switch_ivr_bridge.c:912 BRIDGE THREAD DONE [sofia/default/390402332953]
  1296. 2020-11-19 12:17:00.134922 [NOTICE] switch_ivr_bridge.c:1025 Hangup sofia/default/390402332953 [CS_EXCHANGE_MEDIA] [ORIGINATOR_CANCEL]
  1297. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:654 (sofia/default/390402332953) State EXCHANGE_MEDIA going to sleep
  1298. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:585 (sofia/default/390402332953) Running State Change CS_HANGUP (Cur 2 Tot 1985)
  1299. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:848 (sofia/default/390402332953) Callstate Change EARLY -> HANGUP
  1300. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:850 (sofia/default/390402332953) State HANGUP
  1301. 2020-11-19 12:17:00.134922 [DEBUG] mod_sofia.c:447 sofia/default/390402332953 Overriding SIP cause 487 with 487 from the other leg
  1302. 2020-11-19 12:17:00.134922 [DEBUG] mod_sofia.c:453 Channel sofia/default/390402332953 hanging up, cause: ORIGINATOR_CANCEL
  1303. 2020-11-19 12:17:00.134922 [DEBUG] switch_ivr_bridge.c:1892 sofia/default/390402332953 skip receive message [UNBRIDGE] (channel is hungup already)
  1304. 2020-11-19 12:17:00.134922 [DEBUG] switch_ivr_bridge.c:1895 sofia/default/0110720221@anstel.conexopbx.it skip receive message [UNBRIDGE] (channel is hungup already)
  1305. 2020-11-19 12:17:00.134922 [DEBUG] mod_sofia.c:521 Sending CANCEL to sofia/default/390402332953
  1306. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_session.c:2905 sofia/default/0110720221@anstel.conexopbx.it skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1307. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:651 (sofia/default/0110720221@anstel.conexopbx.it) State EXECUTE going to sleep
  1308. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:585 (sofia/default/0110720221@anstel.conexopbx.it) Running State Change CS_HANGUP (Cur 2 Tot 1985)
  1309. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:60 sofia/default/390402332953 Standard HANGUP, cause: ORIGINATOR_CANCEL
  1310. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:850 (sofia/default/390402332953) State HANGUP going to sleep
  1311. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:620 (sofia/default/390402332953) State Change CS_HANGUP -> CS_REPORTING
  1312. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:585 (sofia/default/390402332953) Running State Change CS_REPORTING (Cur 2 Tot 1985)
  1313. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:848 (sofia/default/0110720221@anstel.conexopbx.it) Callstate Change EARLY -> HANGUP
  1314. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:936 (sofia/default/390402332953) State REPORTING
  1315. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:850 (sofia/default/0110720221@anstel.conexopbx.it) State HANGUP
  1316. 2020-11-19 12:17:00.134922 [DEBUG] mod_sofia.c:453 Channel sofia/default/0110720221@anstel.conexopbx.it hanging up, cause: ORIGINATOR_CANCEL
  1317. 2020-11-19 12:17:00.134922 [INFO] mod_json_cdr.c:271 Process [adb27703-85ae-402e-91c9-d5a1a843e874.cdr.json]
  1318. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:60 sofia/default/0110720221@anstel.conexopbx.it Standard HANGUP, cause: ORIGINATOR_CANCEL
  1319. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:850 (sofia/default/0110720221@anstel.conexopbx.it) State HANGUP going to sleep
  1320. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:620 (sofia/default/0110720221@anstel.conexopbx.it) State Change CS_HANGUP -> CS_REPORTING
  1321. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:585 (sofia/default/0110720221@anstel.conexopbx.it) Running State Change CS_REPORTING (Cur 2 Tot 1985)
  1322. 2020-11-19 12:17:00.134922 [DEBUG] switch_core_state_machine.c:936 (sofia/default/0110720221@anstel.conexopbx.it) State REPORTING
  1323. 2020-11-19 12:17:00.134922 [INFO] mod_json_cdr.c:271 Process [18e31b9d-0f1d-4eee-a048-3473702b1dc4.cdr.json]
  1324. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:174 sofia/default/390402332953 Standard REPORTING, cause: ORIGINATOR_CANCEL
  1325. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:936 (sofia/default/390402332953) State REPORTING going to sleep
  1326. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:611 (sofia/default/390402332953) State Change CS_REPORTING -> CS_DESTROY
  1327. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_session.c:1726 Session 1985 (sofia/default/390402332953) Locked, Waiting on external entities
  1328. 2020-11-19 12:17:00.154917 [NOTICE] switch_core_session.c:1744 Session 1985 (sofia/default/390402332953) Ended
  1329. 2020-11-19 12:17:00.154917 [NOTICE] switch_core_session.c:1748 Close Channel sofia/default/390402332953 [CS_DESTROY]
  1330. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:739 (sofia/default/390402332953) Running State Change CS_DESTROY (Cur 1 Tot 1985)
  1331. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:749 (sofia/default/390402332953) State DESTROY
  1332. 2020-11-19 12:17:00.154917 [DEBUG] mod_sofia.c:364 sofia/default/390402332953 SOFIA DESTROY
  1333. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:181 sofia/default/390402332953 Standard DESTROY
  1334. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:749 (sofia/default/390402332953) State DESTROY going to sleep
  1335. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:174 sofia/default/0110720221@anstel.conexopbx.it Standard REPORTING, cause: ORIGINATOR_CANCEL
  1336. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:936 (sofia/default/0110720221@anstel.conexopbx.it) State REPORTING going to sleep
  1337. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:611 (sofia/default/0110720221@anstel.conexopbx.it) State Change CS_REPORTING -> CS_DESTROY
  1338. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_session.c:1726 Session 1980 (sofia/default/0110720221@anstel.conexopbx.it) Locked, Waiting on external entities
  1339. 2020-11-19 12:17:00.154917 [NOTICE] switch_core_session.c:1744 Session 1980 (sofia/default/0110720221@anstel.conexopbx.it) Ended
  1340. 2020-11-19 12:17:00.154917 [NOTICE] switch_core_session.c:1748 Close Channel sofia/default/0110720221@anstel.conexopbx.it [CS_DESTROY]
  1341. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:739 (sofia/default/0110720221@anstel.conexopbx.it) Running State Change CS_DESTROY (Cur 0 Tot 1985)
  1342. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:749 (sofia/default/0110720221@anstel.conexopbx.it) State DESTROY
  1343. 2020-11-19 12:17:00.154917 [DEBUG] mod_sofia.c:364 sofia/default/0110720221@anstel.conexopbx.it SOFIA DESTROY
  1344. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:181 sofia/default/0110720221@anstel.conexopbx.it Standard DESTROY
  1345. 2020-11-19 12:17:00.154917 [DEBUG] switch_core_state_machine.c:749 (sofia/default/0110720221@anstel.conexopbx.it) State DESTROY going to sleep
  1346. 2020-11-19 12:17:00.414905 [DEBUG] switch_scheduler.c:147 Deleting task 665 switch_ivr_schedule_hangup (adb27703-85ae-402e-91c9-d5a1a843e874)
  1347. freeswitch@pbx2.conexo.tech> /exit
  1348.  
  1349.