From Sandro Bordacchini, 3 Years ago, written in FreeSWITCH.
- view diff
Embed
  1. span style="color: cornflowerblue; font-weight: bold;"> dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.896298 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/242@customer.voip.voipprovider.it:5060 [dc36fb2f-8319-42ae-b432-260172d5156b]
  2. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.896298 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/242@customer.voip.voipprovider.it:5060) Running State Change CS_NEW (Cur 11 Tot 2619)
  3. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.896298 [DEBUG] sofia.c:9825 sofia/internal/242@customer.voip.voipprovider.it:5060 receiving invite from 10.137.2.11:12675 version: 1.6.16 -33-e6d643b 64bit
  4. 2021-05-10 11:51:22.896298 [DEBUG] sofia.c:9996 IP 10.137.2.11 Rejected by acl "domains". Falling back to Digest auth.
  5. 2021-05-10 11:51:22.896298 [WARNING] sofia_reg.c:1792 SIP auth challenge (INVITE) on sofia profile 'internal' for [00privacy95@customer.voip.voipprovider.it] from ip 10.137.2.11
  6. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.896298 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/242@customer.voip.voipprovider.it:5060) State NEW
  7. 2021-05-10 11:51:22.896298 [DEBUG] sofia.c:2334 detaching session dc36fb2f-8319-42ae-b432-260172d5156b
  8. 2021-05-10 11:51:22.916301 [DEBUG] sofia.c:2442 Re-attaching to session dc36fb2f-8319-42ae-b432-260172d5156b
  9. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] sofia.c:9825 sofia/internal/242@customer.voip.voipprovider.it:5060 receiving invite from 10.137.2.11:12675 version: 1.6.16 -33-e6d643b 64bit
  10. 2021-05-10 11:51:22.916301 [DEBUG] sofia.c:9996 IP 10.137.2.11 Rejected by acl "domains". Falling back to Digest auth.
  11. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] sofia.c:7048 Channel sofia/internal/242@customer.voip.voipprovider.it:5060 entering state [received][100]
  12. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] sofia.c:7058 Remote SDP:
  13. dc36fb2f-8319-42ae-b432-260172d5156b v=0
  14. dc36fb2f-8319-42ae-b432-260172d5156b o=- 22971 22971 IN IP4 10.137.2.11
  15. dc36fb2f-8319-42ae-b432-260172d5156b s=SDP data
  16. dc36fb2f-8319-42ae-b432-260172d5156b c=IN IP4 10.137.2.11
  17. dc36fb2f-8319-42ae-b432-260172d5156b t=0 0
  18. dc36fb2f-8319-42ae-b432-260172d5156b m=audio 12420 RTP/AVP 18 9 8 101
  19. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:18 G729/8000
  20. dc36fb2f-8319-42ae-b432-260172d5156b a=fmtp:18 annexb=no
  21. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:9 G722/8000
  22. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:8 PCMA/8000
  23. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:101 telephone-event/8000
  24. dc36fb2f-8319-42ae-b432-260172d5156b a=fmtp:101 0-15
  25. dc36fb2f-8319-42ae-b432-260172d5156b a=ptime:20
  26. dc36fb2f-8319-42ae-b432-260172d5156b
  27. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] sofia.c:7450 (sofia/internal/242@customer.voip.voipprovider.it:5060) State Change CS_NEW -> CS_INIT
  28. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/242@customer.voip.voipprovider.it:5060) Running State Change CS_INIT (Cur 11 Tot 2619)
  29. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/242@customer.voip.voipprovider.it:5060) State INIT
  30. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] mod_sofia.c:90 sofia/internal/242@customer.voip.voipprovider.it:5060 SOFIA INIT
  31. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:40 sofia/internal/242@customer.voip.voipprovider.it:5060 Standard INIT
  32. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/242@customer.voip.voipprovider.it:5060) State Change CS_INIT -> CS_ROUTING
  33. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/242@customer.voip.voipprovider.it:5060) State INIT going to sleep
  34. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/242@customer.voip.voipprovider.it:5060) Running State Change CS_ROUTING (Cur 11 Tot 2619)
  35. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_channel.c:2249 (sofia/internal/242@customer.voip.voipprovider.it:5060) Callstate Change DOWN -> RINGING
  36. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/242@customer.voip.voipprovider.it:5060) State ROUTING
  37. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] mod_sofia.c:143 sofia/internal/242@customer.voip.voipprovider.it:5060 SOFIA ROUTING
  38. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:236 sofia/internal/242@customer.voip.voipprovider.it:5060 Standard ROUTING
  39. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [INFO] mod_dialplan_xml.c:637 Processing 242 <242>->00privacy95 in context customer.voip.voipprovider.it
  40. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 parsing [customer.voip.voipprovider.it->set_callee_and_caller_name] continue=true
  41. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [set_callee_and_caller_name] destination_number(00privacy95) =~ /.*/ break=on-false
  42. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(domain_name=customer.voip.voipprovider.it)
  43. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action curl(http://${3rdparty_address}:${3rdparty_port}/contacts/lookup?number=${destination_number}&domain=${domain_name})
  44. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action export(callee_id_name=${curl_response_data})
  45. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action curl(http://${3rdparty_address}:${3rdparty_port}/contacts/lookup?number=${caller_id_number}&domain=${domain_name}&username=${destination_number}&user_context=false)
  46. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(effective_caller_id_name=${curl_response_data})
  47. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(caller_id_name=${effective_caller_id_name})
  48. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 parsing [customer.voip.voipprovider.it->extension_queue] continue=false
  49. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [extension_queue] destination_number(00privacy95) =~ /^\*800(.*)$/ break=on-false
  50. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 parsing [customer.voip.voipprovider.it->user_exists] continue=true
  51. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Absolute Condition [user_exists]
  52. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
  53. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(user_exists=false)
  54. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [user_exists]=[false]
  55. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
  56. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 parsing [customer.voip.voipprovider.it->call-direction] continue=true
  57. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
  58. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 ANTI-Action set(call_direction=local)
  59. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [call-direction] ${user_exists}(false) =~ /^false$/ break=on-false
  60. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [call-direction] destination_number(00privacy95) =~ /^\d{7,20}$/ break=on-false
  61. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(call_direction=outbound)
  62. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 parsing [customer.voip.voipprovider.it->variables] continue=true
  63. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Absolute Condition [variables]
  64. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action export(origination_callee_id_name=${destination_number})
  65. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  66. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 parsing [customer.voip.voipprovider.it->user_record] continue=true
  67. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Absolute Condition [user_record]
  68. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
  69. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(user_record=)
  70. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [user_record]=[UNDEF]
  71. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
  72. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(from_user_exists=true)
  73. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [from_user_exists]=[true]
  74. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  75. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
  76. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  77. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
  78. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
  79. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  80. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
  81. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
  82. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  83. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
  84. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
  85. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  86. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE
  87. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(from_user_record=)
  88. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [from_user_record]=[UNDEF]
  89. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  90. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
  91. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  92. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
  93. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
  94. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  95. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
  96. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
  97. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  98. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
  99. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
  100. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
  101. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 parsing [customer.voip.voipprovider.it->07PRIVACY8.0d] continue=false
  102. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [07PRIVACY8.0d] destination_number(00privacy95) =~ /^0(\d+)$/ break=on-false
  103. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [07PRIVACY8.0d] ${dialed_extension}() =~ /^$/ break=never
  104. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [07PRIVACY8.0d] destination_number(00privacy95) =~ /^0(\d+)$/ break=on-false
  105. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (FAIL) [07PRIVACY8.0d] ${outbound_caller_id_number}() =~ /^07PRIV4(.*)$/ break=never
  106. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 ANTI-Action set(outbound_caller_id_number=07PRIVACY3)
  107. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Regex (PASS) [07PRIVACY8.0d] destination_number(00privacy95) =~ /^0(\d+)$/ break=on-false
  108. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(sip_h_X-accountcode=${accountcode})
  109. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(sip_h_X-Tag=)
  110. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(call_direction=outbound)
  111. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(continue_on_fail=NORMAL_TEMPORARY_FAILURE,NETWORK_OUT_OF_ORDER,FACILITY_REJECTED,NORMAL_CIRCUIT_CONGESTION,SWITCH_CONGESTION,INVALID_GATEWAY,GATEWAY_DOWN)
  112. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(hangup_after_bridge=true)
  113. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(effective_caller_id_name=${outbound_caller_id_number})
  114. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(effective_caller_id_number=${outbound_caller_id_number})
  115. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(inherit_codec=true)
  116. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(continue_on_fail=true)
  117. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(outbound_prefix=0) INLINE
  118. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(outbound_prefix=0)
  119. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [outbound_prefix]=[0]
  120. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action set(bypass_media=${bypass_media_ext_enable})
  121. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action lua(app.lua pre_bridge_actions outbound_route)
  122. dc36fb2f-8319-42ae-b432-260172d5156b Dialplan: sofia/internal/242@customer.voip.voipprovider.it:5060 Action bridge(sofia/gateway/365c2d2c-6a37-4759-bc24-41492d0ca6b6/0privacy95)
  123. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/242@customer.voip.voipprovider.it:5060) State Change CS_ROUTING -> CS_EXECUTE
  124. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/242@customer.voip.voipprovider.it:5060) State ROUTING going to sleep
  125. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/242@customer.voip.voipprovider.it:5060) Running State Change CS_EXECUTE (Cur 11 Tot 2619)
  126. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/242@customer.voip.voipprovider.it:5060) State EXECUTE
  127. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] mod_sofia.c:198 sofia/internal/242@customer.voip.voipprovider.it:5060 SOFIA EXECUTE
  128. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] switch_core_state_machine.c:328 sofia/internal/242@customer.voip.voipprovider.it:5060 Standard EXECUTE
  129. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(domain_name=customer.voip.voipprovider.it)
  130. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.916301 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [domain_name]=[customer.voip.voipprovider.it]
  131. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 curl(http://localhost:9000/contacts/lookup?number=00privacy95&domain=customer.voip.voipprovider.it)
  132. 2021-05-10 11:51:22.916301 [DEBUG] mod_curl.c:182 method: get, url: http://localhost:9000/contacts/lookup?number=00privacy95&domain=customer.voip.voipprovider.it, content-type: (null)
  133. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 export(callee_id_name=00privacy95)
  134. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [callee_id_name]=[00privacy95]
  135. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 curl(http://localhost:9000/contacts/lookup?number=242&domain=customer.voip.voipprovider.it&username=00privacy95&user_context=false)
  136. 2021-05-10 11:51:22.936300 [DEBUG] mod_curl.c:182 method: get, url: http://localhost:9000/contacts/lookup?number=242&domain=customer.voip.voipprovider.it&username=00privacy95&user_context=false, content-type: (null)
  137. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(effective_caller_id_name=Amministrazione 2 )
  138. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [effective_caller_id_name]=[Amministrazione 2 ]
  139. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(caller_id_name=Amministrazione 2 )
  140. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [caller_id_name]=[Amministrazione 2 ]
  141. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(call_direction=local)
  142. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [call_direction]=[local]
  143. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(call_direction=outbound)
  144. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [call_direction]=[outbound]
  145. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 export(origination_callee_id_name=00privacy95)
  146. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[00privacy95]
  147. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(RFC2822_DATE=Mon, 10 May 2021 11:51:22 +0200)
  148. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [RFC2822_DATE]=[Mon, 10 May 2021 11:51:22 +0200]
  149. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(outbound_caller_id_number=07PRIVACY3)
  150. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [outbound_caller_id_number]=[07PRIVACY3]
  151. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(sip_h_X-accountcode=)
  152. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [sip_h_X-accountcode]=[UNDEF]
  153. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(sip_h_X-Tag=)
  154. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [sip_h_X-Tag]=[UNDEF]
  155. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(call_direction=outbound)
  156. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [call_direction]=[outbound]
  157. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(continue_on_fail=NORMAL_TEMPORARY_FAILURE,NETWORK_OUT_OF_ORDER,FACILITY_REJECTED,NORMAL_CIRCUIT_CONGESTION,SWITCH_CONGESTION,INVALID_GATEWAY,GATEWAY_DOWN)
  158. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [continue_on_fail]=[NORMAL_TEMPORARY_FAILURE,NETWORK_OUT_OF_ORDER,FACILITY_REJECTED,NORMAL_CIRCUIT_CONGESTION,SWITCH_CONGESTION,INVALID_GATEWAY,GATEWAY_DOWN]
  159. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(hangup_after_bridge=true)
  160. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [hangup_after_bridge]=[true]
  161. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(effective_caller_id_name=07PRIVACY3)
  162. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [effective_caller_id_name]=[07PRIVACY3]
  163. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(effective_caller_id_number=07PRIVACY3)
  164. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [effective_caller_id_number]=[07PRIVACY3]
  165. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(inherit_codec=true)
  166. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [inherit_codec]=[true]
  167. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(continue_on_fail=true)
  168. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [continue_on_fail]=[true]
  169. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 set(bypass_media=false)
  170. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] mod_dptools.c:1530 SET sofia/internal/242@customer.voip.voipprovider.it:5060 [bypass_media]=[false]
  171. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 lua(app.lua pre_bridge_actions outbound_route)
  172. 2021-05-10 11:51:22.936300 [INFO] switch_cpp.cpp:1365 [pre_bridge_actions] bridge_destination: outbound_route
  173. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] switch_cpp.cpp:745 CoreSession::setVariable(disable_q850_reason, true)
  174. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] switch_cpp.cpp:1112 sofia/internal/242@customer.voip.voipprovider.it:5060 destroy/unlink session from object
  175. dc36fb2f-8319-42ae-b432-260172d5156b EXECUTE sofia/internal/242@customer.voip.voipprovider.it:5060 bridge(sofia/gateway/365c2d2c-6a37-4759-bc24-41492d0ca6b6/0privacy95)
  176. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] switch_channel.c:1250 sofia/internal/242@customer.voip.voipprovider.it:5060 EXPORTING[export_vars] [domain_name]=[customer.voip.voipprovider.it] to event
  177. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] switch_channel.c:1250 sofia/internal/242@customer.voip.voipprovider.it:5060 EXPORTING[export_vars] [callee_id_name]=[00privacy95] to event
  178. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] switch_channel.c:1250 sofia/internal/242@customer.voip.voipprovider.it:5060 EXPORTING[export_vars] [origination_callee_id_name]=[00privacy95] to event
  179. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:22.936300 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  180. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [NOTICE] switch_channel.c:1104 New Channel sofia/external/0privacy95 [54ae949c-851e-460b-b127-8370603b5c25]
  181. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] mod_sofia.c:4818 (sofia/external/0privacy95) State Change CS_NEW -> CS_INIT
  182. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0privacy95) Running State Change CS_INIT (Cur 12 Tot 2620)
  183. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:627 (sofia/external/0privacy95) State INIT
  184. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] mod_sofia.c:90 sofia/external/0privacy95 SOFIA INIT
  185. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] sofia_glue.c:1295 sofia/external/0privacy95 sending invite version: 1.6.16 -33-e6d643b 64bit
  186. 54ae949c-851e-460b-b127-8370603b5c25 Local SDP:
  187. 54ae949c-851e-460b-b127-8370603b5c25 v=0
  188. 54ae949c-851e-460b-b127-8370603b5c25 o=FreeSWITCH 1620609016 1620609017 IN IP4 185.X.Y.Z
  189. 54ae949c-851e-460b-b127-8370603b5c25 s=FreeSWITCH
  190. 54ae949c-851e-460b-b127-8370603b5c25 c=IN IP4 185.X.Y.Z
  191. 54ae949c-851e-460b-b127-8370603b5c25 t=0 0
  192. 54ae949c-851e-460b-b127-8370603b5c25 m=audio 31266 RTP/AVP 8 101 13
  193. 54ae949c-851e-460b-b127-8370603b5c25 a=rtpmap:8 PCMA/8000
  194. 54ae949c-851e-460b-b127-8370603b5c25 a=rtpmap:101 telephone-event/8000
  195. 54ae949c-851e-460b-b127-8370603b5c25 a=fmtp:101 0-16
  196. 54ae949c-851e-460b-b127-8370603b5c25 a=rtpmap:13 CN/8000
  197. 54ae949c-851e-460b-b127-8370603b5c25 a=ptime:20
  198. 54ae949c-851e-460b-b127-8370603b5c25 a=sendrecv
  199. 54ae949c-851e-460b-b127-8370603b5c25
  200. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:40 sofia/external/0privacy95 Standard INIT
  201. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:48 (sofia/external/0privacy95) State Change CS_INIT -> CS_ROUTING
  202. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:627 (sofia/external/0privacy95) State INIT going to sleep
  203. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0privacy95) Running State Change CS_ROUTING (Cur 12 Tot 2620)
  204. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] sofia.c:7048 Channel sofia/external/0privacy95 entering state [calling][0]
  205. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:643 (sofia/external/0privacy95) State ROUTING
  206. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] mod_sofia.c:143 sofia/external/0privacy95 SOFIA ROUTING
  207. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_ivr_originate.c:67 (sofia/external/0privacy95) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  208. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:643 (sofia/external/0privacy95) State ROUTING going to sleep
  209. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0privacy95) Running State Change CS_CONSUME_MEDIA (Cur 12 Tot 2620)
  210. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:662 (sofia/external/0privacy95) State CONSUME_MEDIA
  211. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.936300 [DEBUG] switch_core_state_machine.c:662 (sofia/external/0privacy95) State CONSUME_MEDIA going to sleep
  212. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:22.956300 [DEBUG] sofia.c:7048 Channel sofia/external/0privacy95 entering state [calling][0]
  213. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] sofia.c:7048 Channel sofia/external/0privacy95 entering state [proceeding][183]
  214. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] sofia.c:7058 Remote SDP:
  215. 54ae949c-851e-460b-b127-8370603b5c25 v=0
  216. 54ae949c-851e-460b-b127-8370603b5c25 o=PVG 460363871 642359767 IN IP4 77.J.K.W
  217. 54ae949c-851e-460b-b127-8370603b5c25 s=-
  218. 54ae949c-851e-460b-b127-8370603b5c25 p=+1 6135555555
  219. 54ae949c-851e-460b-b127-8370603b5c25 c=IN IP4 77.J.K.W
  220. 54ae949c-851e-460b-b127-8370603b5c25 t=0 0
  221. 54ae949c-851e-460b-b127-8370603b5c25 a=sqn: 0
  222. 54ae949c-851e-460b-b127-8370603b5c25 a=cdsc: 1 image udptl t38
  223. 54ae949c-851e-460b-b127-8370603b5c25 a=cpar: a=T38FaxVersion:0
  224. 54ae949c-851e-460b-b127-8370603b5c25 a=cpar: a=T38FaxUdpEC:t38UDPRedundancy
  225. 54ae949c-851e-460b-b127-8370603b5c25 m=audio 44384 RTP/AVP 8 101
  226. 54ae949c-851e-460b-b127-8370603b5c25 a=rtpmap:101 telephone-event/8000
  227. 54ae949c-851e-460b-b127-8370603b5c25 a=fmtp:101 0-15
  228. 54ae949c-851e-460b-b127-8370603b5c25 a=ptime:20
  229. 54ae949c-851e-460b-b127-8370603b5c25
  230. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] switch_core_media.c:4429 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  231. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] switch_core_media.c:4484 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  232. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] switch_core_media.c:4345 Set telephone-event payload to 101@8000
  233. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] switch_core_media.c:3049 Set Codec sofia/external/0privacy95 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  234. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] switch_core_codec.c:111 sofia/external/0privacy95 Original read codec set to PCMA:8
  235. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] switch_core_media.c:4688 Set telephone-event payload to 101@8000
  236. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] switch_core_media.c:4747 sofia/external/0privacy95 Set 2833 dtmf send payload to 101 recv payload to 101
  237. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] switch_core_media.c:6803 AUDIO RTP [sofia/external/0privacy95] 185.X.Y.Z port 31266 -> 77.J.K.W port 44384 codec: 8 ms: 20
  238. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:23.156301 [DEBUG] switch_rtp.c:4095 Starting timer [soft] 160 bytes per 20ms
  239. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:7109 sofia/external/0privacy95 Set 2833 dtmf send payload to 101
  240. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:7116 sofia/external/0privacy95 Set 2833 dtmf receive payload to 101
  241. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:7139 sofia/external/0privacy95 Set rtp dtmf delay to 40
  242. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:24.176307 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/0privacy95!
  243. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_ivr_originate.c:410 Setting codec string on sofia/internal/242@customer.voip.voipprovider.it:5060 to PCMA@8000h@20i
  244. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [INFO] switch_ivr_originate.c:3639 Sending early media
  245. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:4429 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  246. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:4429 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  247. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:4429 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  248. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:4484 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  249. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:4345 Set telephone-event payload to 101@8000
  250. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:3049 Set Codec sofia/internal/242@customer.voip.voipprovider.it:5060 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  251. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_core_codec.c:111 sofia/internal/242@customer.voip.voipprovider.it:5060 Original read codec set to PCMA:8
  252. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:24.176307 [DEBUG] switch_channel.c:3473 (sofia/external/0privacy95) Callstate Change DOWN -> EARLY
  253. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:4688 Set telephone-event payload to 101@8000
  254. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:4747 sofia/internal/242@customer.voip.voipprovider.it:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  255. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_core_media.c:6803 AUDIO RTP [sofia/internal/242@customer.voip.voipprovider.it:5060] 10.137.0.1 port 18642 -> 10.137.2.11 port 12420 codec: 8 ms: 20
  256. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:24.176307 [DEBUG] switch_rtp.c:4095 Starting timer [soft] 160 bytes per 20ms
  257.  
  258.  
  259. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:25.176307 [DEBUG] switch_core_media.c:7109 sofia/internal/242@customer.voip.voipprovider.it:5060 Set 2833 dtmf send payload to 101
  260. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:25.176307 [DEBUG] switch_core_media.c:7116 sofia/internal/242@customer.voip.voipprovider.it:5060 Set 2833 dtmf receive payload to 101
  261. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:25.176307 [DEBUG] switch_core_media.c:7139 sofia/internal/242@customer.voip.voipprovider.it:5060 Set rtp dtmf delay to 40
  262. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:25.176307 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/242@customer.voip.voipprovider.it:5060!
  263. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:25.176307 [DEBUG] switch_channel.c:3473 (sofia/internal/242@customer.voip.voipprovider.it:5060) Callstate Change RINGING -> EARLY
  264. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:25.176307 [DEBUG] switch_core_media.c:6786 Audio params are unchanged for sofia/internal/242@customer.voip.voipprovider.it:5060.
  265. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:25.176307 [DEBUG] mod_sofia.c:2363 Ring SDP:
  266. dc36fb2f-8319-42ae-b432-260172d5156b v=0
  267. dc36fb2f-8319-42ae-b432-260172d5156b o=FreeSWITCH 1620621643 1620621644 IN IP4 10.137.0.1
  268. dc36fb2f-8319-42ae-b432-260172d5156b s=FreeSWITCH
  269. dc36fb2f-8319-42ae-b432-260172d5156b c=IN IP4 10.137.0.1
  270. dc36fb2f-8319-42ae-b432-260172d5156b t=0 0
  271. dc36fb2f-8319-42ae-b432-260172d5156b m=audio 18642 RTP/AVP 8 101
  272. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:8 PCMA/8000
  273. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:101 telephone-event/8000
  274. dc36fb2f-8319-42ae-b432-260172d5156b a=fmtp:101 0-16
  275. dc36fb2f-8319-42ae-b432-260172d5156b a=ptime:20
  276. dc36fb2f-8319-42ae-b432-260172d5156b a=sendrecv
  277. dc36fb2f-8319-42ae-b432-260172d5156b
  278. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:25.176307 [DEBUG] switch_ivr_originate.c:3690 Originate Resulted in Success: [sofia/external/0privacy95]
  279. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:25.176307 [DEBUG] sofia.c:7048 Channel sofia/internal/242@customer.voip.voipprovider.it:5060 entering state [early][183]
  280. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:25.176307 [DEBUG] switch_ivr_bridge.c:1574 (sofia/external/0privacy95) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  281. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:25.176307 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0privacy95) Running State Change CS_EXCHANGE_MEDIA (Cur 14 Tot 2622)
  282. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:25.176307 [DEBUG] switch_core_state_machine.c:653 (sofia/external/0privacy95) State EXCHANGE_MEDIA
  283. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:25.176307 [DEBUG] mod_sofia.c:631 SOFIA EXCHANGE_MEDIA
  284. b71bc5ca-ade8-4845-9f8f-bff70d08f61d 2021-05-10 11:51:25.196300 [DEBUG] switch_rtp.c:7228 Correct audio ip/port confirmed.
  285. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:28.336298 [DEBUG] sofia.c:7048 Channel sofia/external/0privacy95 entering state [completing][200]
  286. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:28.336298 [DEBUG] sofia.c:7055 Duplicate SDP
  287. 54ae949c-851e-460b-b127-8370603b5c25 v=0
  288. 54ae949c-851e-460b-b127-8370603b5c25 o=PVG 460363871 642359767 IN IP4 77.J.K.W
  289. 54ae949c-851e-460b-b127-8370603b5c25 s=-
  290. 54ae949c-851e-460b-b127-8370603b5c25 p=+1 6135555555
  291. 54ae949c-851e-460b-b127-8370603b5c25 c=IN IP4 77.J.K.W
  292. 54ae949c-851e-460b-b127-8370603b5c25 t=0 0
  293. 54ae949c-851e-460b-b127-8370603b5c25 a=sqn: 0
  294. 54ae949c-851e-460b-b127-8370603b5c25 a=cdsc: 1 image udptl t38
  295. 54ae949c-851e-460b-b127-8370603b5c25 a=cpar: a=T38FaxVersion:0
  296. 54ae949c-851e-460b-b127-8370603b5c25 a=cpar: a=T38FaxUdpEC:t38UDPRedundancy
  297. 54ae949c-851e-460b-b127-8370603b5c25 m=audio 44384 RTP/AVP 8 101
  298. 54ae949c-851e-460b-b127-8370603b5c25 a=rtpmap:101 telephone-event/8000
  299. 54ae949c-851e-460b-b127-8370603b5c25 a=fmtp:101 0-15
  300. 54ae949c-851e-460b-b127-8370603b5c25 a=ptime:20
  301. 54ae949c-851e-460b-b127-8370603b5c25
  302. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:28.356299 [DEBUG] sofia.c:7048 Channel sofia/external/0privacy95 entering state [ready][200]
  303. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:28.356299 [NOTICE] sofia.c:8108 Channel [sofia/external/0privacy95] has been answered
  304. 54ae949c-851e-460b-b127-8370603b5c25 2021-05-10 11:51:28.356299 [DEBUG] switch_channel.c:3772 (sofia/external/0privacy95) Callstate Change EARLY -> ACTIVE
  305. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.376300 [DEBUG] switch_core_media.c:6786 Audio params are unchanged for sofia/internal/242@customer.voip.voipprovider.it:5060.
  306. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.376300 [DEBUG] mod_sofia.c:850 Local SDP sofia/internal/242@customer.voip.voipprovider.it:5060:
  307. dc36fb2f-8319-42ae-b432-260172d5156b v=0
  308. dc36fb2f-8319-42ae-b432-260172d5156b o=FreeSWITCH 1620621643 1620621645 IN IP4 10.137.0.1
  309. dc36fb2f-8319-42ae-b432-260172d5156b s=FreeSWITCH
  310. dc36fb2f-8319-42ae-b432-260172d5156b c=IN IP4 10.137.0.1
  311. dc36fb2f-8319-42ae-b432-260172d5156b t=0 0
  312. dc36fb2f-8319-42ae-b432-260172d5156b m=audio 18642 RTP/AVP 8 101
  313. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:8 PCMA/8000
  314. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:101 telephone-event/8000
  315. dc36fb2f-8319-42ae-b432-260172d5156b a=fmtp:101 0-16
  316. dc36fb2f-8319-42ae-b432-260172d5156b a=ptime:20
  317. dc36fb2f-8319-42ae-b432-260172d5156b a=sendrecv
  318. dc36fb2f-8319-42ae-b432-260172d5156b
  319. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.376300 [NOTICE] switch_ivr_bridge.c:598 Channel [sofia/internal/242@customer.voip.voipprovider.it:5060] has been answered
  320. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.376300 [DEBUG] switch_channel.c:3772 (sofia/internal/242@customer.voip.voipprovider.it:5060) Callstate Change EARLY -> ACTIVE
  321. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.376300 [DEBUG] sofia.c:7048 Channel sofia/internal/242@customer.voip.voipprovider.it:5060 entering state [completed][200]
  322. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.396298 [DEBUG] sofia.c:7048 Channel sofia/internal/242@customer.voip.voipprovider.it:5060 entering state [completed][0]
  323. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.396298 [DEBUG] sofia.c:7048 Channel sofia/internal/242@customer.voip.voipprovider.it:5060 entering state [ready][200]
  324. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.416299 [DEBUG] sofia.c:7048 Channel sofia/internal/242@customer.voip.voipprovider.it:5060 entering state [ready][200]
  325. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.416299 [DEBUG] sofia.c:7058 Remote SDP:
  326. dc36fb2f-8319-42ae-b432-260172d5156b v=0
  327. dc36fb2f-8319-42ae-b432-260172d5156b o=- 22971 22972 IN IP4 10.137.2.11
  328. dc36fb2f-8319-42ae-b432-260172d5156b s=SDP data
  329. dc36fb2f-8319-42ae-b432-260172d5156b c=IN IP4 10.137.2.11
  330. dc36fb2f-8319-42ae-b432-260172d5156b t=0 0
  331. dc36fb2f-8319-42ae-b432-260172d5156b m=audio 12420 RTP/AVP 8 101
  332. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:8 PCMA/8000
  333. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:101 telephone-event/8000
  334. dc36fb2f-8319-42ae-b432-260172d5156b a=fmtp:101 0-15
  335. dc36fb2f-8319-42ae-b432-260172d5156b a=ptime:20
  336. dc36fb2f-8319-42ae-b432-260172d5156b
  337. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.416299 [DEBUG] switch_core_media.c:4429 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  338. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.416299 [DEBUG] switch_core_media.c:4484 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  339. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.416299 [DEBUG] switch_core_media.c:4345 Set telephone-event payload to 101@8000
  340. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.416299 [DEBUG] switch_core_media.c:4688 Set telephone-event payload to 101@8000
  341. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.416299 [DEBUG] switch_core_media.c:4747 sofia/internal/242@customer.voip.voipprovider.it:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  342. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.416299 [DEBUG] sofia.c:8010 Processing updated SDP
  343. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.416299 [DEBUG] switch_core_media.c:6786 Audio params are unchanged for sofia/internal/242@customer.voip.voipprovider.it:5060.
  344. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.436298 [DEBUG] sofia.c:7048 Channel sofia/internal/242@customer.voip.voipprovider.it:5060 entering state [calling][0]
  345. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.436298 [DEBUG] sofia.c:7048 Channel sofia/internal/242@customer.voip.voipprovider.it:5060 entering state [ready][200]
  346. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.436298 [DEBUG] sofia.c:7058 Remote SDP:
  347. dc36fb2f-8319-42ae-b432-260172d5156b v=0
  348. dc36fb2f-8319-42ae-b432-260172d5156b o=- 22971 22973 IN IP4 10.137.2.11
  349. dc36fb2f-8319-42ae-b432-260172d5156b s=SDP data
  350. dc36fb2f-8319-42ae-b432-260172d5156b c=IN IP4 10.137.2.11
  351. dc36fb2f-8319-42ae-b432-260172d5156b t=0 0
  352. dc36fb2f-8319-42ae-b432-260172d5156b m=audio 12420 RTP/AVP 8 101
  353. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:8 PCMA/8000
  354. dc36fb2f-8319-42ae-b432-260172d5156b a=rtpmap:101 telephone-event/8000
  355. dc36fb2f-8319-42ae-b432-260172d5156b a=fmtp:101 0-15
  356. dc36fb2f-8319-42ae-b432-260172d5156b a=ptime:20
  357. dc36fb2f-8319-42ae-b432-260172d5156b
  358. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.436298 [DEBUG] switch_core_media.c:4429 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  359. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.436298 [DEBUG] switch_core_media.c:4484 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  360. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.436298 [DEBUG] switch_core_media.c:4345 Set telephone-event payload to 101@8000
  361. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.436298 [DEBUG] switch_core_media.c:4688 Set telephone-event payload to 101@8000
  362. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.436298 [DEBUG] switch_core_media.c:4747 sofia/internal/242@customer.voip.voipprovider.it:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  363. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.436298 [DEBUG] sofia.c:8010 Processing updated SDP
  364. dc36fb2f-8319-42ae-b432-260172d5156b 2021-05-10 11:51:28.436298 [DEBUG] switch_core_media.c:6786 Audio params are unchanged for sofia/internal/242@customer.voip.voipprovider.it:5060.
  365.