From playnet, 2 Years ago, written in Plain Text.
- view diff
Embed
  1. [root@ringme_morskaya freeswitchconf]# egrep -A 30 "67cdaf36-4d0a-11e6-83d9-eb77bd4505f4|67d32966-4d0a-11e6-8410-eb77bd4505f4" /var/log/freeswitch/freeswitch.log.2016-07-18-20-28-37.1
  2. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [NOTICE] switch_channel.c:1077 New Channel sofia/internal/483*101@sipproxy.telphin.ru [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  3. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  4. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  5. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/483*101@sipproxy.telphin.ru) Running State Change CS_NEW
  6. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] sofia.c:8964 sofia/internal/483*101@sipproxy.telphin.ru receiving invite from 213.170.84.105:5060 version: 1.4.26  64bit
  7. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] sofia.c:6658 Channel sofia/internal/483*101@sipproxy.telphin.ru entering state [received][100]
  8. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] sofia.c:6668 Remote SDP:
  9. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 v=0
  10. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 o=root 452279176 452279176 IN IP4 192.77.1.39
  11. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 s=call
  12. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 c=IN IP4 192.77.1.39
  13. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 t=0 0
  14. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 m=audio 52530 RTP/AVP 0 8
  15. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=rtpmap:0 PCMU/8000
  16. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=rtpmap:8 PCMA/8000
  17. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:ZOiSsBfBtnDJYvnzQY5uL6T2kExF0jO8dPZcIHiL
  18. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=ptime:20
  19. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  20. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] sofia.c:6934 (sofia/internal/483*101@sipproxy.telphin.ru) State Change CS_NEW -> CS_INIT
  21. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  22. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_state_machine.c:491 (sofia/internal/483*101@sipproxy.telphin.ru) State NEW
  23. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/483*101@sipproxy.telphin.ru) Running State Change CS_INIT
  24. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/483*101@sipproxy.telphin.ru) State INIT
  25. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] mod_sofia.c:87 sofia/internal/483*101@sipproxy.telphin.ru SOFIA INIT
  26. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_state_machine.c:40 sofia/internal/483*101@sipproxy.telphin.ru Standard INIT
  27. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/483*101@sipproxy.telphin.ru) State Change CS_INIT -> CS_ROUTING
  28. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  29. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/483*101@sipproxy.telphin.ru) State INIT going to sleep
  30. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/483*101@sipproxy.telphin.ru) Running State Change CS_ROUTING
  31. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_channel.c:2206 (sofia/internal/483*101@sipproxy.telphin.ru) Callstate Change DOWN -> RINGING
  32. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/483*101@sipproxy.telphin.ru) State ROUTING
  33. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] mod_sofia.c:123 sofia/internal/483*101@sipproxy.telphin.ru SOFIA ROUTING
  34. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [DEBUG] switch_core_state_machine.c:166 sofia/internal/483*101@sipproxy.telphin.ru Standard ROUTING
  35. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.776394 [INFO] mod_dialplan_xml.c:635 Processing 101 <483*101>->89031883186 in context public
  36. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru parsing [public->Pre-sets] continue=true
  37. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Absolute Condition [Pre-sets]
  38. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_h_X-FromID=10494)
  39. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action log(INFO sip_h_X-FromID=${sip_h_X-FromID})
  40. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(X-Next=@)
  41. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action log(INFO X-Next=${X-Next})
  42. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_received_port=5060)
  43. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action log(INFO sip_received_port=${sip_received_port})
  44. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru parsing [public->check_inbound] continue=true
  45. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Absolute Condition [check_inbound]
  46. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(X-need-bind=True) INLINE
  47. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(X-need-bind=True)
  48. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [X-need-bind]=[True]
  49. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action log(info set: X-need-bind=True)
  50. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru parsing [public->check_outbound] continue=true
  51. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Absolute Condition [check_outbound]
  52. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action export(nolocal:X-need-bind=False) INLINE
  53. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru export(nolocal:X-need-bind=False)
  54. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_channel.c:1269 EXPORT (export_vars) (REMOTE ONLY) [X-need-bind]=[False]
  55. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action log(info export: nolocal:X-need-bind=False)
  56. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru parsing [public->PRELOAD extension] continue=true
  57. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Absolute Condition [PRELOAD extension]
  58. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(X-preloaded=true)
  59. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(transfer_ringback=${us-ring})
  60. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(ringback=${us-ring})
  61. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_copy_custom_headers=true)
  62. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_rh_X-UUID=${uuid})
  63. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_ph_X-UUID=${uuid})
  64. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action unset(invalid_option_key)
  65. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action unset(X-AttXferred)
  66. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Regex (PASS) [PRELOAD extension] ${sip_received_port}(5060) =~ /^(\d+)$/ break=never
  67. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_received_port=5060)
  68. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Regex (PASS) [PRELOAD extension] ${sip_ph_X-Call-UUID}() =~ /^$/ break=never
  69. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action log(INFO NO X-Call-UUID, setting sip_*h_X-Call-UUID=${call_uuid})
  70. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_h_X-Call-UUID=${call_uuid})
  71. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_rh_X-Call-UUID=${call_uuid})
  72. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_ph_X-Call-UUID=${call_uuid})
  73. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru parsing [public->BIND keys extension] continue=true
  74. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Absolute Condition [BIND keys extension]
  75. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action log(debug bind run HERE)
  76. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(bridge_pre_execute_bleg_app=execute_extension)
  77. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(bridge_pre_execute_bleg_data=bind XML features)
  78. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action bind_digit_action(none,NONE,api:sleep,1)
  79. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action bind_digit_action(none_a,NONE,api:sleep,1)
  80. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Regex (PASS) [BIND keys extension] ${X-need-bind}(True) =~ /[Tt]rue/ break=on-false
  81. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action log(debug bind run HERE)
  82. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(X-binded=true)
  83. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(X-LegA=true)
  84. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action export(nolocal:X-LegB=true)
  85. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(transfer_ringback=${us-ring})
  86. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(ringback=${us-ring})
  87. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action bind_digit_action(bind,999,exec:playback,ivr/ivr-welcome_to_freeswitch.wav)
  88. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action bind_digit_action(bind,*1,exec:execute_extension,manual_record XML features)
  89. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action bind_digit_action(bind,#1,exec:execute_extension, dx XML features)
  90. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action bind_digit_action(bind,*2,exec:execute_extension,att_xfer XML features)
  91. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action digit_action_set_realm(bind)
  92. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action bind_digit_action(none,NONE,api:sleep,1)
  93. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action bind_digit_action(none_a,NONE,api:sleep,1)
  94. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru parsing [public->resolve-ext] continue=true
  95. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Absolute Condition [resolve-ext]
  96. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action push(X-ResolveArray=dial=89031883186@sipproxy.telphin.ru;fromid=10494;fromName=483*101@sipproxy.telphin.ru;fromCid=1236;fromDid=1;fromType=phone;resolving=89031883186;ts=${strmicroepoch()})
  97. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action export(X-ResolveArray=${X-ResolveArray})
  98. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action log(INFO X-ResolveArray=${X-ResolveArray})
  99. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru parsing [public->to_kamailio, default DP @ (based on sip.ringme)] continue=false
  100. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Regex (PASS) [to_kamailio, default DP @ (based on sip.ringme)] destination_number(89031883186) =~ /^(.*)$/ break=on-false
  101. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_copy_custom_headers=true)
  102. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_to_port=${sip_from_port})
  103. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action set(sip_invite_domain=${sip_from_host})
  104. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action info()
  105. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action log(DEBUG sofia_profile_name=${sofia_profile_name})
  106. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Dialplan: sofia/internal/483*101@sipproxy.telphin.ru Action bridge({absolute_codec_string=PCMA,PCMU}sofia/internal/89031883186@${sip_invite_domain}:${sip_network_port})
  107. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/483*101@sipproxy.telphin.ru) State Change CS_ROUTING -> CS_EXECUTE
  108. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  109. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/483*101@sipproxy.telphin.ru) State ROUTING going to sleep
  110. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/483*101@sipproxy.telphin.ru) Running State Change CS_EXECUTE
  111. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/483*101@sipproxy.telphin.ru) State EXECUTE
  112. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_sofia.c:178 sofia/internal/483*101@sipproxy.telphin.ru SOFIA EXECUTE
  113. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:258 sofia/internal/483*101@sipproxy.telphin.ru Standard EXECUTE
  114. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_h_X-FromID=10494)
  115. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_h_X-FromID]=[10494]
  116. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru log(INFO sip_h_X-FromID=10494)
  117. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [INFO] mod_dptools.c:1670 sip_h_X-FromID=10494
  118. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(X-Next=@)
  119. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [X-Next]=[@]
  120. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru log(INFO X-Next=@)
  121. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [INFO] mod_dptools.c:1670 X-Next=@
  122. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_received_port=5060)
  123. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_received_port]=[5060]
  124. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru log(INFO sip_received_port=5060)
  125. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [INFO] mod_dptools.c:1670 sip_received_port=5060
  126. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru log(info set: X-need-bind=True)
  127. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [INFO] mod_dptools.c:1670 set: X-need-bind=True
  128. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru log(info export: nolocal:X-need-bind=False)
  129. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [INFO] mod_dptools.c:1670 export: nolocal:X-need-bind=False
  130. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(X-preloaded=true)
  131. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [X-preloaded]=[true]
  132. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(transfer_ringback=%(2000,4000,440,480))
  133. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [transfer_ringback]=[%(2000,4000,440,480)]
  134. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(ringback=%(2000,4000,440,480))
  135. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [ringback]=[%(2000,4000,440,480)]
  136. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_copy_custom_headers=true)
  137. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_copy_custom_headers]=[true]
  138. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_rh_X-UUID=67cdaf36-4d0a-11e6-83d9-eb77bd4505f4)
  139. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_rh_X-UUID]=[67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  140. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_ph_X-UUID=67cdaf36-4d0a-11e6-83d9-eb77bd4505f4)
  141. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_ph_X-UUID]=[67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  142. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru unset(invalid_option_key)
  143. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1621 UNSET [invalid_option_key]
  144. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru unset(X-AttXferred)
  145. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1621 UNSET [X-AttXferred]
  146. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_received_port=5060)
  147. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_received_port]=[5060]
  148. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru log(INFO NO X-Call-UUID, setting sip_*h_X-Call-UUID=67cdaf36-4d0a-11e6-83d9-eb77bd4505f4)
  149. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [INFO] mod_dptools.c:1670 NO X-Call-UUID, setting sip_*h_X-Call-UUID=67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  150. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_h_X-Call-UUID=67cdaf36-4d0a-11e6-83d9-eb77bd4505f4)
  151. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_h_X-Call-UUID]=[67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  152. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_rh_X-Call-UUID=67cdaf36-4d0a-11e6-83d9-eb77bd4505f4)
  153. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_rh_X-Call-UUID]=[67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  154. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_ph_X-Call-UUID=67cdaf36-4d0a-11e6-83d9-eb77bd4505f4)
  155. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_ph_X-Call-UUID]=[67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  156. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru log(debug bind run HERE)
  157. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1670 bind run HERE
  158. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(bridge_pre_execute_bleg_app=execute_extension)
  159. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [bridge_pre_execute_bleg_app]=[execute_extension]
  160. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(bridge_pre_execute_bleg_data=bind XML features)
  161. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [bridge_pre_execute_bleg_data]=[bind XML features]
  162. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru bind_digit_action(none,NONE,api:sleep,1)
  163. 2016-07-18 20:09:36.816381 [INFO] switch_ivr_async.c:212 Digit parser DPTOOLS: Setting realm to 'none'
  164. 2016-07-18 20:09:36.816381 [DEBUG] switch_ivr_async.c:321 Digit parser DPTOOLS: binding NONE/none/0 callback: 0x7f62853f9d70 data: 0x7f61b4362a10
  165. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru bind_digit_action(none_a,NONE,api:sleep,1)
  166. 2016-07-18 20:09:36.816381 [INFO] switch_ivr_async.c:212 Digit parser DPTOOLS: Setting realm to 'none_a'
  167. 2016-07-18 20:09:36.816381 [DEBUG] switch_ivr_async.c:321 Digit parser DPTOOLS: binding NONE/none_a/0 callback: 0x7f62853f9d70 data: 0x7f61b4362ad0
  168. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru log(debug bind run HERE)
  169. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1670 bind run HERE
  170. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(X-binded=true)
  171. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [X-binded]=[true]
  172. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(X-LegA=true)
  173. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [X-LegA]=[true]
  174. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru export(nolocal:X-LegB=true)
  175. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_channel.c:1269 EXPORT (export_vars) (REMOTE ONLY) [X-LegB]=[true]
  176. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(transfer_ringback=%(2000,4000,440,480))
  177. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [transfer_ringback]=[%(2000,4000,440,480)]
  178. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(ringback=%(2000,4000,440,480))
  179. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [ringback]=[%(2000,4000,440,480)]
  180. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru bind_digit_action(bind,999,exec:playback,ivr/ivr-welcome_to_freeswitch.wav)
  181. 2016-07-18 20:09:36.816381 [INFO] switch_ivr_async.c:212 Digit parser DPTOOLS: Setting realm to 'bind'
  182. 2016-07-18 20:09:36.816381 [DEBUG] switch_ivr_async.c:321 Digit parser DPTOOLS: binding 999/bind/0 callback: 0x7f62853f9d70 data: 0x7f61b481bce8
  183. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru bind_digit_action(bind,*1,exec:execute_extension,manual_record XML features)
  184. 2016-07-18 20:09:36.816381 [DEBUG] switch_ivr_async.c:321 Digit parser DPTOOLS: binding *1/bind/0 callback: 0x7f62853f9d70 data: 0x7f61b481be18
  185. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru bind_digit_action(bind,#1,exec:execute_extension, dx XML features)
  186. 2016-07-18 20:09:36.816381 [DEBUG] switch_ivr_async.c:321 Digit parser DPTOOLS: binding #1/bind/0 callback: 0x7f62853f9d70 data: 0x7f61b481bf28
  187. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru bind_digit_action(bind,*2,exec:execute_extension,att_xfer XML features)
  188. 2016-07-18 20:09:36.816381 [DEBUG] switch_ivr_async.c:321 Digit parser DPTOOLS: binding *2/bind/0 callback: 0x7f62853f9d70 data: 0x7f61b481c038
  189. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru digit_action_set_realm(bind)
  190. 2016-07-18 20:09:36.816381 [INFO] switch_ivr_async.c:212 Digit parser DPTOOLS: Setting realm to 'bind'
  191. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru bind_digit_action(none,NONE,api:sleep,1)
  192. 2016-07-18 20:09:36.816381 [DEBUG] switch_ivr_async.c:321 Reuse Existing Digit parser DPTOOLS: binding NONE/none/0 callback: 0x7f62853f9d70 data: 0x7f61b481c158
  193. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru bind_digit_action(none_a,NONE,api:sleep,1)
  194. 2016-07-18 20:09:36.816381 [DEBUG] switch_ivr_async.c:321 Reuse Existing Digit parser DPTOOLS: binding NONE/none_a/0 callback: 0x7f62853f9d70 data: 0x7f61b481c218
  195. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru push(X-ResolveArray=dial=89031883186@sipproxy.telphin.ru;fromid=10494;fromName=483*101@sipproxy.telphin.ru;fromCid=1236;fromDid=1;fromType=phone;resolving=89031883186;ts=1468861776816381)
  196. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [X-ResolveArray]=[dial=89031883186@sipproxy.telphin.ru;fromid=10494;fromName=483*101@sipproxy.telphin.ru;fromCid=1236;fromDid=1;fromType=phone;resolving=89031883186;ts=1468861776816381]
  197. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru export(X-ResolveArray=dial=89031883186@sipproxy.telphin.ru;fromid=10494;fromName=483*101@sipproxy.telphin.ru;fromCid=1236;fromDid=1;fromType=phone;resolving=89031883186;ts=1468861776816381)
  198. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_channel.c:1269 EXPORT (export_vars) [X-ResolveArray]=[dial=89031883186@sipproxy.telphin.ru;fromid=10494;fromName=483*101@sipproxy.telphin.ru;fromCid=1236;fromDid=1;fromType=phone;resolving=89031883186;ts=1468861776816381]
  199. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru log(INFO X-ResolveArray=dial=89031883186@sipproxy.telphin.ru;fromid=10494;fromName=483*101@sipproxy.telphin.ru;fromCid=1236;fromDid=1;fromType=phone;resolving=89031883186;ts=1468861776816381)
  200. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [INFO] mod_dptools.c:1670 X-ResolveArray=dial=89031883186@sipproxy.telphin.ru;fromid=10494;fromName=483*101@sipproxy.telphin.ru;fromCid=1236;fromDid=1;fromType=phone;resolving=89031883186;ts=1468861776816381
  201. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_copy_custom_headers=true)
  202. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_copy_custom_headers]=[true]
  203. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_to_port=)
  204. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_to_port]=[UNDEF]
  205. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru set(sip_invite_domain=sipproxy.telphin.ru)
  206. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1477 sofia/internal/483*101@sipproxy.telphin.ru SET [sip_invite_domain]=[sipproxy.telphin.ru]
  207. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru info()
  208. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [INFO] mod_dptools.c:1689 CHANNEL_DATA:
  209. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Channel-State: [CS_EXECUTE]
  210. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Channel-Call-State: [RINGING]
  211. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Channel-State-Number: [4]
  212. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Channel-Name: [sofia/internal/483*101@sipproxy.telphin.ru]
  213. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Unique-ID: [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  214. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Call-Direction: [inbound]
  215. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Presence-Call-Direction: [inbound]
  216. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Channel-HIT-Dialplan: [true]
  217. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Channel-Presence-ID: [483*101@sipproxy.telphin.ru]
  218. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Channel-Call-UUID: [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  219. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Answer-State: [ringing]
  220. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Direction: [inbound]
  221. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Logical-Direction: [inbound]
  222. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Username: [483*101]
  223. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Dialplan: [XML]
  224. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Caller-ID-Name: [101]
  225. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Caller-ID-Number: [483*101]
  226. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Orig-Caller-ID-Name: [101]
  227. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Orig-Caller-ID-Number: [483*101]
  228. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Network-Addr: [213.170.84.105]
  229. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-ANI: [483*101]
  230. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Destination-Number: [89031883186]
  231. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Unique-ID: [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  232. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Source: [mod_sofia]
  233. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Context: [public]
  234. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Name: [sofia/internal/483*101@sipproxy.telphin.ru]
  235. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Profile-Index: [1]
  236. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Profile-Created-Time: [1468861776776394]
  237. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Created-Time: [1468861776776394]
  238. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Answered-Time: [0]
  239. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Progress-Time: [0]
  240. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Progress-Media-Time: [0]
  241. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Hangup-Time: [0]
  242. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Transfer-Time: [0]
  243. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Resurrect-Time: [0]
  244. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Bridged-Time: [0]
  245. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Last-Hold: [0]
  246. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Channel-Hold-Accum: [0]
  247. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Screen-Bit: [true]
  248. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Privacy-Hide-Name: [false]
  249. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Caller-Privacy-Hide-Number: [false]
  250. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_direction: [inbound]
  251. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_uuid: [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  252. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_session_id: [527445]
  253. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_from_user: [483*101]
  254. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_from_uri: [483*101@sipproxy.telphin.ru]
  255. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_from_host: [sipproxy.telphin.ru]
  256. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_channel_name: [sofia/internal/483*101@sipproxy.telphin.ru]
  257. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_call_id: [313436383836313736383137333538-szm2qy7cw9b5]
  258. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_ep_codec_string: [PCMU@8000h@20i@64000b,PCMA@8000h@20i@64000b]
  259. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_local_network_addr: [213.170.84.101]
  260. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_network_ip: [213.170.84.105]
  261. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_network_port: [5060]
  262. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_received_ip: [213.170.84.105]
  263. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_via_protocol: [udp]
  264. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_from_user_stripped: [483*101]
  265. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_from_tag: [qcs4gzhfbm]
  266. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sofia_profile_name: [internal]
  267. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_recovery_profile_name: [internal]
  268. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_invite_record_route: [<sip:89031883186@213.170.84.105;lr=on;ftag=qcs4gzhfbm;did=ce7.2093;nat=yes>]
  269. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_full_via: [SIP/2.0/UDP 213.170.84.105;branch=z9hG4bK128c.ddb49169c57340c936ae2d3371f4b342.0,SIP/2.0/UDP 192.77.1.39:57113;received=212.5.164.15;branch=z9hG4bK-16yyljhw5ql2;rport=57113]
  270. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_from_display: [101]
  271. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_full_from: ["101" <sip:483*101@sipproxy.telphin.ru>;tag=qcs4gzhfbm]
  272. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_full_to: [<sip:89031883186@sipproxy.telphin.ru;user=phone>]
  273. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_req_params: [user=phone]
  274. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_req_user: [89031883186]
  275. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_req_uri: [89031883186@sipproxy.telphin.ru]
  276. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_req_host: [sipproxy.telphin.ru]
  277. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_to_params: [user=phone]
  278. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_to_user: [89031883186]
  279. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_to_uri: [89031883186@sipproxy.telphin.ru]
  280. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_to_host: [sipproxy.telphin.ru]
  281. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_contact_params: [line=b2dj73bg;alias=212.5.164.15~57113~1]
  282. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_contact_user: [483*101]
  283. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_contact_port: [57113]
  284. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_contact_uri: [483*101@192.77.1.39:57113]
  285. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_contact_host: [192.77.1.39]
  286. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_rtp_use_codec_string: [OPUS,PCMA,PCMU,G722]
  287. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_user_agent: [snom715/8.7.5.35]
  288. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_via_host: [213.170.84.105]
  289. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_max_forwards: [69]
  290. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_presence_id: [483*101@sipproxy.telphin.ru]
  291. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_h_X-Inring: [pId=10494;srcId=10494;srcDid=1;srcCid=1236;srcExt=483*101@sipproxy.telphin.ru;srcType=phone]
  292. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_h_X-Serialnumber: [0004137543FB]
  293. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_sip_h_P-Key-Flags: [resolution="31x13", keys="4"]
  294. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_switch_r_sdp: [v=0
  295. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 o=root 452279176 452279176 IN IP4 192.77.1.39
  296. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 s=call
  297. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 c=IN IP4 192.77.1.39
  298. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 t=0 0
  299. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 m=audio 52530 RTP/AVP 0 8
  300. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=rtpmap:0 PCMU/8000
  301. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=rtpmap:8 PCMA/8000
  302. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:ZOiSsBfBtnDJYvnzQY5uL6T2kExF0jO8dPZcIHiL
  303. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=ptime:20
  304. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 ]
  305. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_endpoint_disposition: [DELAYED NEGOTIATION]
  306. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_X-need-bind: [True]
  307. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 variable_nolocal:X-need-bind: [False]
  308. variable_DP_MATCH: [ARRAY::89031883186|:89031883186]
  309. variable_call_uuid: [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  310. variable_sip_h_X-FromID: [10494]
  311. variable_X-Next: [@]
  312. variable_X-preloaded: [true]
  313. variable_sip_rh_X-UUID: [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  314. variable_sip_ph_X-UUID: [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  315. variable_sip_received_port: [5060]
  316. variable_sip_h_X-Call-UUID: [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  317. variable_sip_rh_X-Call-UUID: [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  318. variable_sip_ph_X-Call-UUID: [67cdaf36-4d0a-11e6-83d9-eb77bd4505f4]
  319. variable_bridge_pre_execute_bleg_app: [execute_extension]
  320. variable_bridge_pre_execute_bleg_data: [bind XML features]
  321. variable_X-binded: [true]
  322. variable_X-LegA: [true]
  323. variable_nolocal:X-LegB: [true]
  324. variable_transfer_ringback: [%(2000,4000,440,480)]
  325. variable_ringback: [%(2000,4000,440,480)]
  326. variable_X-ResolveArray: [dial=89031883186@sipproxy.telphin.ru;fromid=10494;fromName=483*101@sipproxy.telphin.ru;fromCid=1236;fromDid=1;fromType=phone;resolving=89031883186;ts=1468861776816381]
  327. variable_export_vars: [nolocal:X-need-bind,nolocal:X-LegB,X-ResolveArray]
  328. variable_sip_copy_custom_headers: [true]
  329. variable_sip_invite_domain: [sipproxy.telphin.ru]
  330. variable_current_application: [info]
  331.  
  332.  
  333.  
  334. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru log(DEBUG sofia_profile_name=internal)
  335. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_dptools.c:1670 sofia_profile_name=internal
  336. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 EXECUTE sofia/internal/483*101@sipproxy.telphin.ru bridge({absolute_codec_string=PCMA,PCMU}sofia/internal/89031883186@sipproxy.telphin.ru:5060)
  337. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_channel.c:1223 sofia/internal/483*101@sipproxy.telphin.ru EXPORTING[export_vars] [X-need-bind]=[False] to event
  338. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_channel.c:1223 sofia/internal/483*101@sipproxy.telphin.ru EXPORTING[export_vars] [X-LegB]=[true] to event
  339. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_channel.c:1223 sofia/internal/483*101@sipproxy.telphin.ru EXPORTING[export_vars] [X-ResolveArray]=[dial=89031883186@sipproxy.telphin.ru;fromid=10494;fromName=483*101@sipproxy.telphin.ru;fromCid=1236;fromDid=1;fromType=phone;resolving=89031883186;ts=1468861776816381] to event
  340. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_ivr_originate.c:2124 Parsing global variables
  341. 2016-07-18 20:09:36.816381 [DEBUG] switch_event.c:1698 Parsing variable [absolute_codec_string]=[PCMA,PCMU]
  342. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [NOTICE] switch_channel.c:1077 New Channel sofia/internal/89031883186@sipproxy.telphin.ru:5060 [67d32966-4d0a-11e6-8410-eb77bd4505f4]
  343. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_sofia.c:4700 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State Change CS_NEW -> CS_INIT
  344. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  345. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Running State Change CS_INIT
  346. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State INIT
  347. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_sofia.c:87 sofia/internal/89031883186@sipproxy.telphin.ru:5060 SOFIA INIT
  348. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] sofia_glue.c:1241 sofia/internal/89031883186@sipproxy.telphin.ru:5060 sending invite version: 1.4.26  64bit
  349. 67d32966-4d0a-11e6-8410-eb77bd4505f4 Local SDP:
  350. 67d32966-4d0a-11e6-8410-eb77bd4505f4 v=0
  351. 67d32966-4d0a-11e6-8410-eb77bd4505f4 o=RINGME 1468835608 1468835609 IN IP4 213.170.84.101
  352. 67d32966-4d0a-11e6-8410-eb77bd4505f4 s=RINGME
  353. 67d32966-4d0a-11e6-8410-eb77bd4505f4 c=IN IP4 213.170.84.101
  354. 67d32966-4d0a-11e6-8410-eb77bd4505f4 t=0 0
  355. 67d32966-4d0a-11e6-8410-eb77bd4505f4 m=audio 26168 RTP/AVP 8 0 101 13
  356. 67d32966-4d0a-11e6-8410-eb77bd4505f4 a=rtpmap:8 PCMA/8000
  357. 67d32966-4d0a-11e6-8410-eb77bd4505f4 a=rtpmap:0 PCMU/8000
  358. 67d32966-4d0a-11e6-8410-eb77bd4505f4 a=rtpmap:101 telephone-event/8000
  359. 67d32966-4d0a-11e6-8410-eb77bd4505f4 a=fmtp:101 0-16
  360. 67d32966-4d0a-11e6-8410-eb77bd4505f4 a=ptime:20
  361. 67d32966-4d0a-11e6-8410-eb77bd4505f4 a=sendrecv
  362. 67d32966-4d0a-11e6-8410-eb77bd4505f4
  363. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:40 sofia/internal/89031883186@sipproxy.telphin.ru:5060 Standard INIT
  364. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State Change CS_INIT -> CS_ROUTING
  365. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  366. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State INIT going to sleep
  367. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Running State Change CS_ROUTING
  368. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  369. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] sofia.c:6658 Channel sofia/internal/89031883186@sipproxy.telphin.ru:5060 entering state [calling][0]
  370. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State ROUTING
  371. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] mod_sofia.c:123 sofia/internal/89031883186@sipproxy.telphin.ru:5060 SOFIA ROUTING
  372. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  373. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  374. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State ROUTING going to sleep
  375. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Running State Change CS_CONSUME_MEDIA
  376. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:547 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State CONSUME_MEDIA
  377. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:36.816381 [DEBUG] switch_core_state_machine.c:547 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State CONSUME_MEDIA going to sleep
  378. 66cdb3d8-4d0a-11e6-839e-eb77bd4505f4 2016-07-18 20:09:36.936380 [INFO] switch_rtp.c:5901 Auto Changing port from 10.215.148.237:10000 to 107.107.56.49:22204
  379. 420a2e3c-4d0a-11e6-80bc-eb77bd4505f4 2016-07-18 20:09:38.096411 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:09:38.100164] SSRC[601823969]RTT[0.030228] A[2345802148] - DLSR[185453] - LSR[2345614714]
  380. 07446efc-4d0a-11e6-b938-eb77bd4505f4 2016-07-18 20:09:40.336381 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:09:40.355469] SSRC[462318916]RTT[0.041336] A[2345949952] - DLSR[289580] - LSR[2345657663]
  381. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:40.776419 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [BREAK]
  382. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:40.776419 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [BREAK]
  383. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:40.776419 [DEBUG] sofia.c:6658 Channel sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 entering state [proceeding][180]
  384. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:43.096391 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  385. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:43.096391 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  386. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:43.096391 [DEBUG] sofia.c:6658 Channel sofia/internal/89031883186@sipproxy.telphin.ru:5060 entering state [proceeding][180]
  387. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:43.096391 [NOTICE] sofia.c:6760 Ring-Ready sofia/internal/89031883186@sipproxy.telphin.ru:5060!
  388. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:43.096391 [DEBUG] switch_channel.c:3299 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Callstate Change DOWN -> RINGING
  389. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [INFO] switch_ivr_originate.c:1215 Sending early media
  390. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:1228 looking for crypto suite [AEAD_AES_256_GCM_8] in [1 AES_CM_128_HMAC_SHA1_80 inline:ZOiSsBfBtnDJYvnzQY5uL6T2kExF0jO8dPZcIHiL]
  391. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:1228 looking for crypto suite [AEAD_AES_128_GCM_8] in [1 AES_CM_128_HMAC_SHA1_80 inline:ZOiSsBfBtnDJYvnzQY5uL6T2kExF0jO8dPZcIHiL]
  392. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:1228 looking for crypto suite [AES_CM_256_HMAC_SHA1_80] in [1 AES_CM_128_HMAC_SHA1_80 inline:ZOiSsBfBtnDJYvnzQY5uL6T2kExF0jO8dPZcIHiL]
  393. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:1228 looking for crypto suite [AES_CM_192_HMAC_SHA1_80] in [1 AES_CM_128_HMAC_SHA1_80 inline:ZOiSsBfBtnDJYvnzQY5uL6T2kExF0jO8dPZcIHiL]
  394. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:1228 looking for crypto suite [AES_CM_128_HMAC_SHA1_80] in [1 AES_CM_128_HMAC_SHA1_80 inline:ZOiSsBfBtnDJYvnzQY5uL6T2kExF0jO8dPZcIHiL]
  395. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:1233 Found suite AES_CM_128_HMAC_SHA1_80
  396. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:1299 Set Remote Key [1 AES_CM_128_HMAC_SHA1_80 inline:ZOiSsBfBtnDJYvnzQY5uL6T2kExF0jO8dPZcIHiL]
  397. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:965 Set Local audio crypto Key [1 AES_CM_128_HMAC_SHA1_80 inline:oxTSAIX0VXc3+C3qvMv1UhZp9PBcfLjvVHFRHAH7]
  398. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  399. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  400. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  401. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  402. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  403. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  404. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  405. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  406. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  407. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  408. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:2506 Set Codec sofia/internal/483*101@sipproxy.telphin.ru PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  409. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_codec.c:111 sofia/internal/483*101@sipproxy.telphin.ru Original read codec set to PCMU:0
  410. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:3955 No 2833 in SDP.  Disable 2833 dtmf and switch to INFO
  411. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:5178 AUDIO RTP [sofia/internal/483*101@sipproxy.telphin.ru] 213.170.84.101 port 20380 -> 192.77.1.39 port 52530 codec: 0 ms: 20
  412. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_rtp.c:3608 Starting timer [soft] 160 bytes per 20ms
  413. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:1747 Setting Jitterbuffer to 305ms (15 frames) (75 max frames) (0 max drift)
  414. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_media.c:5504 sofia/internal/483*101@sipproxy.telphin.ru Set rtp dtmf delay to 40
  415. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [INFO] switch_rtp.c:3423 Activating Audio Secure RTP SEND
  416. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [INFO] switch_rtp.c:3401 Activating Audio Secure RTP RECV
  417. 2016-07-18 20:09:43.116443 [DEBUG] switch_core_sqldb.c:2599 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
  418. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/483*101@sipproxy.telphin.ru!
  419. 2016-07-18 20:09:43.116443 [DEBUG] switch_core_sqldb.c:2599 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
  420. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_channel.c:3421 (sofia/internal/483*101@sipproxy.telphin.ru) Callstate Change RINGING -> EARLY
  421. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] mod_sofia.c:2264 Ring SDP:
  422. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 v=0
  423. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 o=RINGME 1468841403 1468841404 IN IP4 213.170.84.101
  424. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 s=RINGME
  425. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 c=IN IP4 213.170.84.101
  426. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 t=0 0
  427. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 m=audio 20380 RTP/SAVP 0
  428. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=rtpmap:0 PCMU/8000
  429. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=ptime:20
  430. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=sendrecv
  431. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:oxTSAIX0VXc3+C3qvMv1UhZp9PBcfLjvVHFRHAH7
  432. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  433. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  434. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_ivr_originate.c:1272 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  435. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_core_codec.c:221 sofia/internal/483*101@sipproxy.telphin.ru Push codec L16:100
  436. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.116443 [DEBUG] switch_ivr_originate.c:1341 Play Ringback Tone [%(2000,4000,440,480)]
  437. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:43.136397 [DEBUG] sofia.c:6658 Channel sofia/internal/483*101@sipproxy.telphin.ru entering state [early][183]
  438. 420a2e3c-4d0a-11e6-80bc-eb77bd4505f4 2016-07-18 20:09:43.336406 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:09:43.340191] SSRC[601823969]RTT[0.030716] A[2346145558] - DLSR[201151] - LSR[2345942394]
  439. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [BREAK]
  440. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [BREAK]
  441. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] sofia.c:6658 Channel sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 entering state [completing][200]
  442. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] sofia.c:6668 Remote SDP:
  443. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 v=0
  444. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 o=- 1468861781 1468861781 IN IP4 109.107.176.42
  445. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 s=-
  446. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 c=IN IP4 109.107.176.42
  447. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 t=0 0
  448. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 m=audio 15198 RTP/AVP 8 0 101
  449. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 a=rtpmap:8 PCMA/8000
  450. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 a=rtpmap:0 PCMU/8000
  451. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 a=rtpmap:101 telephone-event/8000
  452. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 a=fmtp:101 0-15
  453. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 a=ptime:20
  454. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 a=silenceSupp:off - - - -
  455. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4
  456. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [BREAK]
  457. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [BREAK]
  458. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] sofia.c:6658 Channel sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 entering state [ready][200]
  459. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  460. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  461. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  462. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  463. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  464. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  465. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_media.c:3595 Set telephone-event payload to 101
  466. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_media.c:2506 Set Codec sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  467. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:44.596426 [DEBUG] switch_core_codec.c:111 sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 Original read codec set to PCMA:8
  468. --
  469. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  470. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  471. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] sofia.c:6658 Channel sofia/internal/89031883186@sipproxy.telphin.ru:5060 entering state [completing][200]
  472. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] sofia.c:6668 Remote SDP:
  473. 67d32966-4d0a-11e6-8410-eb77bd4505f4 v=0
  474. 67d32966-4d0a-11e6-8410-eb77bd4505f4 o=AudiocodesGW 1064695897 1064695870 IN IP4 31.200.203.137
  475. 67d32966-4d0a-11e6-8410-eb77bd4505f4 s=Phone-Call
  476. 67d32966-4d0a-11e6-8410-eb77bd4505f4 c=IN IP4 31.200.203.137
  477. 67d32966-4d0a-11e6-8410-eb77bd4505f4 t=0 0
  478. 67d32966-4d0a-11e6-8410-eb77bd4505f4 m=audio 9070 RTP/AVP 8 13 101
  479. 67d32966-4d0a-11e6-8410-eb77bd4505f4 c=IN IP4 31.200.203.137
  480. 67d32966-4d0a-11e6-8410-eb77bd4505f4 a=rtpmap:8 PCMA/8000
  481. 67d32966-4d0a-11e6-8410-eb77bd4505f4 a=rtpmap:101 telephone-event/8000
  482. 67d32966-4d0a-11e6-8410-eb77bd4505f4 a=fmtp:101 0-15
  483. 67d32966-4d0a-11e6-8410-eb77bd4505f4 a=ptime:20
  484. 67d32966-4d0a-11e6-8410-eb77bd4505f4
  485. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  486. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  487. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] sofia.c:6658 Channel sofia/internal/89031883186@sipproxy.telphin.ru:5060 entering state [ready][200]
  488. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  489. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  490. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  491. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] switch_core_media.c:3595 Set telephone-event payload to 101
  492. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] switch_core_media.c:2506 Set Codec sofia/internal/89031883186@sipproxy.telphin.ru:5060 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  493. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.476399 [DEBUG] switch_core_codec.c:111 sofia/internal/89031883186@sipproxy.telphin.ru:5060 Original read codec set to PCMA:8
  494. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_media.c:3933 Set 2833 dtmf send payload to 101
  495. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_media.c:5178 AUDIO RTP [sofia/internal/89031883186@sipproxy.telphin.ru:5060] 213.170.84.101 port 26168 -> 31.200.203.137 port 9070 codec: 8 ms: 20
  496. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_rtp.c:3608 Starting timer [soft] 160 bytes per 20ms
  497. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_media.c:1747 Setting Jitterbuffer to 305ms (15 frames) (75 max frames) (0 max drift)
  498. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_media.c:5476 Set 2833 dtmf send payload to 101
  499. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_media.c:5482 Set 2833 dtmf receive payload to 101
  500. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_media.c:5504 sofia/internal/89031883186@sipproxy.telphin.ru:5060 Set rtp dtmf delay to 40
  501. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_media.c:5510 Set comfort noise payload to 13
  502. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_channel.c:3659 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  503. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [NOTICE] sofia.c:7525 Channel [sofia/internal/89031883186@sipproxy.telphin.ru:5060] has been answered
  504. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_codec.c:246 sofia/internal/483*101@sipproxy.telphin.ru Restore previous codec PCMU:0.
  505. 2016-07-18 20:09:46.496391 [INFO] switch_cpp.cpp:1358 direction -> outbound
  506. 2016-07-18 20:09:46.496391 [INFO] switch_cpp.cpp:1358 Other-Leg-UUID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  507.  
  508. 2016-07-18 20:09:46.496391 [INFO] switch_cpp.cpp:1358 leg2i srcId=10494;srcDid=1;srcCid=1236;srcExt=483*101@sipproxy.telphin.ru;srcType=phone
  509.  
  510. 2016-07-18 20:09:46.496391 [DEBUG] switch_cpp.cpp:1358 sets 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 Other-Leg-X-Leg2i srcId=10494;srcDid=1;srcCid=1236;srcExt=483*101@sipproxy.telphin.ru;srcType=phone
  511.  
  512. 2016-07-18 20:09:46.496391 [DEBUG] switch_cpp.cpp:1358 result +OK
  513.  
  514.  
  515. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] mod_sofia.c:780 Local SDP sofia/internal/483*101@sipproxy.telphin.ru:
  516. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 v=0
  517. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 o=RINGME 1468841403 1468841405 IN IP4 213.170.84.101
  518. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 s=RINGME
  519. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 c=IN IP4 213.170.84.101
  520. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 t=0 0
  521. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 m=audio 20380 RTP/SAVP 0
  522. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=rtpmap:0 PCMU/8000
  523. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=ptime:20
  524. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=sendrecv
  525. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:oxTSAIX0VXc3+C3qvMv1UhZp9PBcfLjvVHFRHAH7
  526. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  527. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  528. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [NOTICE] switch_ivr_originate.c:3546 Channel [sofia/internal/483*101@sipproxy.telphin.ru] has been answered
  529. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  530. 2016-07-18 20:09:46.496391 [DEBUG] switch_cpp.cpp:1358 init record-check script, 'Event-Name: CHANNEL_ANSWER
  531. Core-UUID: 253cff26-478a-11e6-9300-eb77bd4505f4
  532. FreeSWITCH-Hostname: ringme_morskaya
  533. FreeSWITCH-Switchname: ringme_morskaya
  534. FreeSWITCH-IPv4: 213.170.84.101
  535. FreeSWITCH-IPv6: %3A%3A1
  536. Event-Date-Local: 2016-07-18%2020%3A09%3A46
  537. Event-Date-GMT: Mon,%2018%20Jul%202016%2017%3A09%3A46%20GMT
  538. Event-Date-Timestamp: 1468861786496391
  539. Event-Calling-File: switch_channel.c
  540. Event-Calling-Function: switch_channel_perform_mark_answered
  541. Event-Calling-Line-Number: 3649
  542. Event-Sequence: 26421755
  543. Channel-State: CS_CONSUME_MEDIA
  544. Channel-Call-State: RINGING
  545. Channel-State-Number: 7
  546. Channel-Name: sofia/internal/89031883186%40sipproxy.telphin.ru%3A5060
  547. Unique-ID: 67d32966-4d0a-11e6-8410-eb77bd4505f4
  548. Call-Direction: outbound
  549. Presence-Call-Direction: outbound
  550. Channel-HIT-Dialplan: false
  551. Channel-Call-UUID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  552. Answer-State: answered
  553. Channel-Read-Codec-Name: PCMA
  554. Channel-Read-Codec-Rate: 8000
  555. Channel-Read-Codec-Bit-Rate: 64000
  556. Channel-Write-Codec-Name: PCMA
  557. Channel-Write-Codec-Rate: 8000
  558. Channel-Write-Codec-Bit-Rate: 64000
  559. Caller-Direction: outbound
  560. Caller-Logical-Direction: outbound
  561. Caller-Username: 483*101
  562. Caller-Dialplan: XML
  563. Caller-Caller-ID-Name: 101
  564. Caller-Caller-ID-Number: 483*101
  565. Caller-Orig-Caller-ID-Name: 101
  566. Caller-Orig-Caller-ID-Number: 483*101
  567. Caller-Callee-ID-Name: Outbound%20Call
  568. Caller-Callee-ID-Number: 89031883186
  569. Caller-Network-Addr: 213.170.84.100
  570. Caller-ANI: 483*101
  571. Caller-Destination-Number: 89031883186
  572. Caller-Unique-ID: 67d32966-4d0a-11e6-8410-eb77bd4505f4
  573. Caller-Source: mod_sofia
  574. Caller-Context: public
  575. Caller-Channel-Name: sofia/internal/89031883186%40sipproxy.telphin.ru%3A5060
  576. Caller-Profile-Index: 1
  577. Caller-Profile-Created-Time: 1468861776816381
  578. Caller-Channel-Created-Time: 1468861776816381
  579. Caller-Channel-Answered-Time: 1468861786496391
  580. Caller-Channel-Progress-Time: 1468861783096391
  581. Caller-Channel-Progress-Media-Time: 0
  582. Caller-Channel-Hangup-Time: 0
  583. Caller-Channel-Transfer-Time: 0
  584. Caller-Channel-Resurrect-Time: 0
  585. Caller-Channel-Bridged-Time: 0
  586. Caller-Channel-Last-Hold: 0
  587. Caller-Channel-Hold-Accum: 0
  588. Caller-Screen-Bit: true
  589. Caller-Privacy-Hide-Name: false
  590. Caller-Privacy-Hide-Number: false
  591. Other-Type: originator
  592. Other-Leg-Direction: inbound
  593. Other-Leg-Logical-Direction: inbound
  594. Other-Leg-Username: 483*101
  595. Other-Leg-Dialplan: XML
  596. Other-Leg-Caller-ID-Name: 101
  597. Other-Leg-Caller-ID-Number: 483*101
  598. Other-Leg-Orig-Caller-ID-Name: 101
  599. Other-Leg-Orig-Caller-ID-Number: 483*101
  600. Other-Leg-Network-Addr: 213.170.84.105
  601. Other-Leg-ANI: 483*101
  602. Other-Leg-Destination-Number: 89031883186
  603. Other-Leg-Unique-ID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  604. Other-Leg-Source: mod_sofia
  605. Other-Leg-Context: public
  606. Other-Leg-Channel-Name: sofia/internal/483*101%40sipproxy.telphin.ru
  607. Other-Leg-Profile-Created-Time: 0
  608. Other-Leg-Channel-Created-Time: 0
  609. Other-Leg-Channel-Answered-Time: 0
  610. Other-Leg-Channel-Progress-Time: 1468861783096391
  611. Other-Leg-Channel-Progress-Media-Time: 0
  612. Other-Leg-Channel-Hangup-Time: 0
  613. Other-Leg-Channel-Transfer-Time: 0
  614. Other-Leg-Channel-Resurrect-Time: 0
  615. Other-Leg-Channel-Bridged-Time: 0
  616. Other-Leg-Channel-Last-Hold: 0
  617. Other-Leg-Channel-Hold-Accum: 0
  618. Other-Leg-Screen-Bit: true
  619. Other-Leg-Privacy-Hide-Name: false
  620. Other-Leg-Privacy-Hide-Number: false
  621. variable_direction: outbound
  622. variable_is_outbound: true
  623. variable_uuid: 67d32966-4d0a-11e6-8410-eb77bd4505f4
  624. variable_session_id: 527446
  625. variable_sip_profile_name: internal
  626. variable_channel_name: sofia/internal/89031883186%40sipproxy.telphin.ru%3A5060
  627. variable_sip_destination_url: sip%3A89031883186%40sipproxy.telphin.ru%3A5060
  628. variable_sip_h_X-Inring: pId%3D10494%3BsrcId%3D10494%3BsrcDid%3D1%3BsrcCid%3D1236%3BsrcExt%3D483*101%40sipproxy.telphin.ru%3BsrcType%3Dphone
  629. variable_sip_h_X-Serialnumber: 0004137543FB
  630. variable_sip_h_P-Key-Flags: resolution%3D%2231x13%22,%20keys%3D%224%22
  631. variable_sip_h_X-FromID: 10494
  632. variable_sip_h_X-Call-UUID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  633. variable_max_forwards: 68
  634. variable_originator_codec: PCMU%408000h%4020i%4064000b,PCMA%408000h%4020i%4064000b
  635. variable_originator: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  636. variable_signal_bond: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  637. variable_switch_m_sdp: v%3D0%0D%0Ao%3Droot%20452279176%20452279176%20IN%20IP4%20192.77.1.39%0D%0As%3Dcall%0D%0Ac%3DIN%20IP4%20192.77.1.39%0D%0At%3D0%200%0D%0Am%3Daudio%2052530%20RTP/AVP%200%208%0D%0Aa%3Drtpmap%3A0%20PCMU/8000%0D%0Aa%3Drtpmap%3A8%20PCMA/8000%0D%0Aa%3Dcrypto%3A1%20AES_CM_128_HMAC_SHA1_80%20inline%3AZOiSsBfBtnDJYvnzQY5uL6T2kExF0jO8dPZcIHiL%0D%0Aa%3Dptime%3A20%0D%0A
  638. variable_call_uuid: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  639. variable_export_vars: nolocal%3AX-need-bind,nolocal%3AX-LegB,X-ResolveArray
  640. variable_X-need-bind: False
  641. variable_X-LegB: true
  642. variable_X-ResolveArray: dial%3D89031883186%40sipproxy.telphin.ru%3Bfromid%3D10494%3BfromName%3D483*101%40sipproxy.telphin.ru%3BfromCid%3D1236%3BfromDid%3D1%3BfromType%3Dphone%3Bresolving%3D89031883186%3Bts%3D1468861776816381
  643. variable_absolute_codec_string: PCMA,PCMU
  644. variable_originate_early_media: true
  645. variable_originating_leg_uuid: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  646. variable_rtp_local_sdp_str: v%3D0%0Ao%3DRINGME%201468835608%201468835609%20IN%20IP4%20213.170.84.101%0As%3DRINGME%0Ac%3DIN%20IP4%20213.170.84.101%0At%3D0%200%0Am%3Daudio%2026168%20RTP/AVP%208%200%20101%2013%0Aa%3Drtpmap%3A8%20PCMA/8000%0Aa%3Drtpmap%3A0%20PCMU/8000%0Aa%3Drtpmap%3A101%20telephone-event/8000%0Aa%3Dfmtp%3A101%200-16%0Aa%3Dptime%3A20%0Aa%3Dsendrecv%0A
  647. variable_sip_outgoing_contact_uri: %3Csip%3Amod_sofia%40213.170.84.101%3A5080%3E
  648. variable_sip_req_uri: 89031883186%40sipproxy.telphin.ru%3A5060
  649. variable_sofia_profile_name: internal
  650. variable_recovery_profile_name: internal
  651. variable_sip_ph_X-Leg2i: srcId%3D10494%3BsrcDid%3D1%3BsrcCid%3D1236%3BsrcExt%3D483*101%40sipproxy.telphin.ru%3BsrcType%3Dphone
  652. variable_sip_local_network_addr: 213.170.84.101
  653. variable_sip_reply_host: 213.170.84.100
  654. variable_sip_reply_port: 5060
  655. variable_sip_network_ip: 213.170.84.100
  656. variable_sip_network_port: 5060
  657. variable_ep_codec_string: PCMA%408000h%4020i%4064000b
  658. variable_sip_rh_X-Leg2i: srcId%3D10494%3BsrcDid%3D1%3BsrcCid%3D1236%3BsrcExt%3D483*101%40sipproxy.telphin.ru%3BsrcType%3Dphone
  659. variable_sip_user_agent: Mediant%201000/v.6.60A.260.002
  660. variable_sip_recover_contact: %3Csip%3A1089%4031.200.203.137%3A5060%3E
  661. variable_sip_invite_record_route: %3Csip%3A89031883186%40213.170.84.100%3Blr%3Don%3Bftag%3D57ZS3ymar7SyD%3Bdid%3D9a4.af62%3E,%3Csip%3A89031883186%40213.170.92.166%3Blr%3Don%3Bftag%3D57ZS3ymar7SyD%3Bldi%3D9a42.ae36%3E,%3Csip%3A79031883186%40213.170.92.166%3A5062%3Blr%3Don%3Bftag%3D57ZS3ymar7SyD%3E,%3Csip%3A213.170.100.150%3Blr%3Bftag%3D57ZS3ymar7SyD%3Bdid%3D9a4.59073695%3E
  662. variable_sip_full_via: SIP/2.0/UDP%20213.170.84.101%3A5080%3Brport%3Bbranch%3Dz9hG4bKjyjmpaHarrepc
  663. variable_sip_recover_via: SIP/2.0/UDP%20213.170.84.101%3A5080%3Brport%3Bbranch%3Dz9hG4bKjyjmpaHarrepc
  664. variable_sip_from_display: 101
  665. variable_sip_full_from: %22101%22%20%3Csip%3A483*101%40213.170.84.101%3E%3Btag%3D57ZS3ymar7SyD
  666. variable_sip_full_to: %3Csip%3A89031883186%40sipproxy.telphin.ru%3E%3Btag%3D1c1059679600
  667. variable_sip_from_user: 483*101
  668. variable_sip_from_uri: 483*101%40213.170.84.101
  669. variable_sip_from_host: 213.170.84.101
  670. variable_sip_to_user: 89031883186
  671. variable_sip_to_uri: 89031883186%40sipproxy.telphin.ru
  672. variable_sip_to_host: sipproxy.telphin.ru
  673. variable_sip_contact_user: 1089
  674. variable_sip_contact_port: 5060
  675. variable_sip_contact_uri: 1089%4031.200.203.137%3A5060
  676. --
  677. variable_sip_call_id: 67d32966-4d0a-11e6-8410-eb77bd4505f4
  678. variable_switch_r_sdp: v%3D0%0D%0Ao%3DAudiocodesGW%201064695897%201064695870%20IN%20IP4%2031.200.203.137%0D%0As%3DPhone-Call%0D%0Ac%3DIN%20IP4%2031.200.203.137%0D%0At%3D0%200%0D%0Am%3Daudio%209070%20RTP/AVP%208%2013%20101%0D%0Ac%3DIN%20IP4%2031.200.203.137%0D%0Aa%3Drtpmap%3A8%20PCMA/8000%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-15%0D%0Aa%3Dptime%3A20%0D%0A
  679. variable_rtp_use_codec_string: PCMA,PCMU
  680. variable_rtp_audio_recv_pt: 8
  681. variable_rtp_use_codec_name: PCMA
  682. variable_rtp_use_codec_rate: 8000
  683. variable_rtp_use_codec_ptime: 20
  684. variable_rtp_use_codec_channels: 1
  685. variable_rtp_last_audio_codec_string: PCMA%408000h%4020i%401c
  686. variable_read_codec: PCMA
  687. variable_original_read_codec: PCMA
  688. variable_read_rate: 8000
  689. variable_original_read_rate: 8000
  690. variable_write_codec: PCMA
  691. variable_write_rate: 8000
  692. variable_dtmf_type: rfc2833
  693. variable_local_media_ip: 213.170.84.101
  694. variable_local_media_port: 26168
  695. variable_advertised_media_ip: 213.170.84.101
  696. variable_rtp_use_timer_name: soft
  697. variable_rtp_use_pt: 8
  698. variable_rtp_use_ssrc: 195096992
  699. variable_rtp_2833_send_payload: 101
  700. variable_rtp_2833_recv_payload: 101
  701. variable_remote_media_ip: 31.200.203.137
  702. variable_remote_media_port: 9070
  703.  
  704. '67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_channel.c:3713 (sofia/internal/483*101@sipproxy.telphin.ru) Callstate Change EARLY -> ACTIVE
  705. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] sofia.c:6658 Channel sofia/internal/483*101@sipproxy.telphin.ru entering state [completed][200]
  706. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_ivr_originate.c:3604 Originate Resulted in Success: [sofia/internal/89031883186@sipproxy.telphin.ru:5060]
  707. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_media.c:7929 sofia/internal/89031883186@sipproxy.telphin.ru:5060 PAUSE Jitterbuffer
  708. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  709. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_media.c:7929 sofia/internal/483*101@sipproxy.telphin.ru PAUSE Jitterbuffer
  710. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  711. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_ivr_bridge.c:1473 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  712. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  713. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Running State Change CS_EXCHANGE_MEDIA
  714. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] switch_core_state_machine.c:538 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State EXCHANGE_MEDIA
  715. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.496391 [DEBUG] mod_sofia.c:594 SOFIA EXCHANGE_MEDIA
  716. 2016-07-18 20:09:46.516385 [INFO] switch_cpp.cpp:1358 direction -> inbound
  717. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.536401 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  718. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.536401 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  719. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.536401 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  720. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.536401 [DEBUG] switch_rtp.c:5928 Correct ip/port confirmed.
  721. 2016-07-18 20:09:46.536401 [INFO] switch_cpp.cpp:1358 hook/event-CHANNEL_ANSWER-for-record_start.lua starting
  722. 2016-07-18 20:09:46.536401 [DEBUG] switch_cpp.cpp:1358 init record-check script, 'Event-Name: CHANNEL_ANSWER
  723. Core-UUID: 253cff26-478a-11e6-9300-eb77bd4505f4
  724. FreeSWITCH-Hostname: ringme_morskaya
  725. FreeSWITCH-Switchname: ringme_morskaya
  726. FreeSWITCH-IPv4: 213.170.84.101
  727. FreeSWITCH-IPv6: %3A%3A1
  728. Event-Date-Local: 2016-07-18%2020%3A09%3A46
  729. Event-Date-GMT: Mon,%2018%20Jul%202016%2017%3A09%3A46%20GMT
  730. Event-Date-Timestamp: 1468861786496391
  731. Event-Calling-File: switch_channel.c
  732. Event-Calling-Function: switch_channel_perform_mark_answered
  733. Event-Calling-Line-Number: 3649
  734. Event-Sequence: 26421759
  735. Channel-State: CS_EXECUTE
  736. Channel-Call-State: EARLY
  737. Channel-State-Number: 4
  738. Channel-Name: sofia/internal/483*101%40sipproxy.telphin.ru
  739. Unique-ID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  740. Call-Direction: inbound
  741. Presence-Call-Direction: inbound
  742. Channel-HIT-Dialplan: true
  743. Channel-Presence-ID: 483*101%40sipproxy.telphin.ru
  744. Channel-Call-UUID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  745. Answer-State: answered
  746. Channel-Read-Codec-Name: PCMU
  747. Channel-Read-Codec-Rate: 8000
  748. Channel-Read-Codec-Bit-Rate: 64000
  749. Channel-Write-Codec-Name: PCMU
  750. Channel-Write-Codec-Rate: 8000
  751. Channel-Write-Codec-Bit-Rate: 64000
  752. Caller-Direction: inbound
  753. Caller-Logical-Direction: inbound
  754. Caller-Username: 483*101
  755. Caller-Dialplan: XML
  756. Caller-Caller-ID-Name: 101
  757. Caller-Caller-ID-Number: 483*101
  758. Caller-Orig-Caller-ID-Name: 101
  759. Caller-Orig-Caller-ID-Number: 483*101
  760. Caller-Callee-ID-Name: Outbound%20Call
  761. Caller-Callee-ID-Number: 89031883186
  762. Caller-Network-Addr: 213.170.84.105
  763. Caller-ANI: 483*101
  764. Caller-Destination-Number: 89031883186
  765. Caller-Unique-ID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  766. Caller-Source: mod_sofia
  767. Caller-Context: public
  768. Caller-Channel-Name: sofia/internal/483*101%40sipproxy.telphin.ru
  769. Caller-Profile-Index: 1
  770. Caller-Profile-Created-Time: 1468861776776394
  771. Caller-Channel-Created-Time: 1468861776776394
  772. Caller-Channel-Answered-Time: 1468861786496391
  773. Caller-Channel-Progress-Time: 1468861783096391
  774. Caller-Channel-Progress-Media-Time: 1468861783116443
  775. Caller-Channel-Hangup-Time: 0
  776. Caller-Channel-Transfer-Time: 0
  777. Caller-Channel-Resurrect-Time: 0
  778. Caller-Channel-Bridged-Time: 0
  779. Caller-Channel-Last-Hold: 0
  780. Caller-Channel-Hold-Accum: 0
  781. Caller-Screen-Bit: true
  782. Caller-Privacy-Hide-Name: false
  783. Caller-Privacy-Hide-Number: false
  784. variable_direction: inbound
  785. variable_uuid: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  786. variable_session_id: 527445
  787. variable_sip_from_user: 483*101
  788. variable_sip_from_uri: 483*101%40sipproxy.telphin.ru
  789. variable_sip_from_host: sipproxy.telphin.ru
  790. variable_channel_name: sofia/internal/483*101%40sipproxy.telphin.ru
  791. variable_sip_call_id: 313436383836313736383137333538-szm2qy7cw9b5
  792. variable_ep_codec_string: PCMU%408000h%4020i%4064000b,PCMA%408000h%4020i%4064000b
  793. variable_sip_local_network_addr: 213.170.84.101
  794. variable_sip_network_ip: 213.170.84.105
  795. variable_sip_network_port: 5060
  796. variable_sip_received_ip: 213.170.84.105
  797. variable_sip_via_protocol: udp
  798. variable_sip_from_user_stripped: 483*101
  799. variable_sip_from_tag: qcs4gzhfbm
  800. variable_sofia_profile_name: internal
  801. variable_recovery_profile_name: internal
  802. variable_sip_invite_record_route: %3Csip%3A89031883186%40213.170.84.105%3Blr%3Don%3Bftag%3Dqcs4gzhfbm%3Bdid%3Dce7.2093%3Bnat%3Dyes%3E
  803. variable_sip_full_via: SIP/2.0/UDP%20213.170.84.105%3Bbranch%3Dz9hG4bK128c.ddb49169c57340c936ae2d3371f4b342.0,SIP/2.0/UDP%20192.77.1.39%3A57113%3Breceived%3D212.5.164.15%3Bbranch%3Dz9hG4bK-16yyljhw5ql2%3Brport%3D57113
  804. variable_sip_from_display: 101
  805. variable_sip_full_from: %22101%22%20%3Csip%3A483*101%40sipproxy.telphin.ru%3E%3Btag%3Dqcs4gzhfbm
  806. variable_sip_full_to: %3Csip%3A89031883186%40sipproxy.telphin.ru%3Buser%3Dphone%3E
  807. variable_sip_req_params: user%3Dphone
  808. variable_sip_req_user: 89031883186
  809. variable_sip_req_uri: 89031883186%40sipproxy.telphin.ru
  810. variable_sip_req_host: sipproxy.telphin.ru
  811. variable_sip_to_params: user%3Dphone
  812. variable_sip_to_user: 89031883186
  813. variable_sip_to_uri: 89031883186%40sipproxy.telphin.ru
  814. variable_sip_to_host: sipproxy.telphin.ru
  815. variable_sip_contact_params: line%3Db2dj73bg%3Balias%3D212.5.164.15~57113~1
  816. --
  817. variable_call_uuid: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  818. variable_sip_h_X-FromID: 10494
  819. variable_X-Next: %40
  820. variable_X-preloaded: true
  821. variable_sip_rh_X-UUID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  822. variable_sip_ph_X-UUID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  823. variable_sip_received_port: 5060
  824. variable_sip_h_X-Call-UUID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  825. variable_sip_rh_X-Call-UUID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  826. variable_sip_ph_X-Call-UUID: 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4
  827. variable_bridge_pre_execute_bleg_app: execute_extension
  828. variable_bridge_pre_execute_bleg_data: bind%20XML%20features
  829. variable_X-binded: true
  830. variable_X-LegA: true
  831. variable_nolocal:X-LegB: true
  832. variable_transfer_ringback: %25(2000,4000,440,480)
  833. variable_ringback: %25(2000,4000,440,480)
  834. variable_X-ResolveArray: dial%3D89031883186%40sipproxy.telphin.ru%3Bfromid%3D10494%3BfromName%3D483*101%40sipproxy.telphin.ru%3BfromCid%3D1236%3BfromDid%3D1%3BfromType%3Dphone%3Bresolving%3D89031883186%3Bts%3D1468861776816381
  835. variable_export_vars: nolocal%3AX-need-bind,nolocal%3AX-LegB,X-ResolveArray
  836. variable_sip_copy_custom_headers: true
  837. variable_sip_invite_domain: sipproxy.telphin.ru
  838. variable_current_application_data: %7Babsolute_codec_string%3D'PCMA,PCMU'%7Dsofia/internal/89031883186%40sipproxy.telphin.ru%3A5060
  839. variable_current_application: bridge
  840. variable_originate_disposition: failure
  841. variable_DIALSTATUS: INVALIDARGS
  842. variable_originate_signal_bond: 67d32966-4d0a-11e6-8410-eb77bd4505f4
  843. variable_originated_legs: 67d32966-4d0a-11e6-8410-eb77bd4505f4%3BOutbound%20Call%3B89031883186
  844. variable_sip_ph_X-Leg2i: srcId%3D10494%3BsrcDid%3D1%3BsrcCid%3D1236%3BsrcExt%3D483*101%40sipproxy.telphin.ru%3BsrcType%3Dphone
  845. variable_rtp_use_codec_string: OPUS,PCMA,PCMU,G722
  846. variable_srtp_remote_audio_crypto_key: 1%20AES_CM_128_HMAC_SHA1_80%20inline%3AZOiSsBfBtnDJYvnzQY5uL6T2kExF0jO8dPZcIHiL
  847. variable_srtp_remote_audio_crypto_type: AES_CM_128_HMAC_SHA1_80
  848. variable_rtp_has_crypto: AES_CM_128_HMAC_SHA1_80
  849. variable_rtp_last_audio_local_crypto_key: 1%20AES_CM_128_HMAC_SHA1_80%20inline%3AoxTSAIX0VXc3%2BC3qvMv1UhZp9PBcfLjvVHFRHAH7
  850. variable_rtp_audio_recv_pt: 0
  851. variable_rtp_use_codec_name: PCMU
  852. variable_rtp_use_codec_rate: 8000
  853. variable_rtp_use_codec_ptime: 20
  854. variable_rtp_use_codec_channels: 1
  855. variable_rtp_last_audio_codec_string: PCMU%408000h%4020i%401c
  856. variable_original_read_codec: PCMU
  857. variable_original_read_rate: 8000
  858. variable_write_codec: PCMU
  859. variable_write_rate: 8000
  860. variable_dtmf_type: info
  861. variable_local_media_ip: 213.170.84.101
  862. variable_local_media_port: 20380
  863. variable_advertised_media_ip: 213.170.84.101
  864. variable_rtp_use_timer_name: soft
  865. variable_rtp_use_pt: 0
  866. variable_rtp_use_ssrc: 3490658896
  867. variable_send_silence_when_idle: -1
  868. variable_rtp_secure_audio_confirmed: true
  869. variable_rtp_secure_media_negotiated: AES_CM_128_HMAC_SHA1_80
  870. variable_remote_media_ip: 192.77.1.39
  871. variable_remote_media_port: 52530
  872. variable_endpoint_disposition: EARLY%20MEDIA
  873. variable_sip_rh_X-Leg2i: srcId%3D10494%3BsrcDid%3D1%3BsrcCid%3D1236%3BsrcExt%3D483*101%40sipproxy.telphin.ru%3BsrcType%3Dphone
  874. --
  875. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.536401 [DEBUG] sofia.c:6658 Channel sofia/internal/483*101@sipproxy.telphin.ru entering state [ready][200]
  876. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.536401 [DEBUG] switch_core_session.c:979 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  877. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.536401 [DEBUG] switch_core_session.c:979 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  878. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.556382 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  879. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.576381 [NOTICE] sofia.c:952 Hangup sofia/internal/483*101@sipproxy.telphin.ru [CS_EXECUTE] [NORMAL_CLEARING]
  880. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.576381 [DEBUG] switch_channel.c:3244 Send signal sofia/internal/483*101@sipproxy.telphin.ru [KILL]
  881. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.576381 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  882. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.576381 [DEBUG] switch_ivr_bridge.c:665 BRIDGE THREAD DONE [sofia/internal/483*101@sipproxy.telphin.ru]
  883. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.576381 [DEBUG] switch_ivr_bridge.c:695 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  884. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_ivr_bridge.c:584 sofia/internal/483*101@sipproxy.telphin.ru ending bridge by request from write function
  885. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_ivr_bridge.c:665 BRIDGE THREAD DONE [sofia/internal/89031883186@sipproxy.telphin.ru:5060]
  886. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_ivr_bridge.c:695 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  887. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [NOTICE] switch_ivr_bridge.c:763 Hangup sofia/internal/89031883186@sipproxy.telphin.ru:5060 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  888. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_channel.c:3244 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [KILL]
  889. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  890. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:538 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State EXCHANGE_MEDIA going to sleep
  891. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Running State Change CS_HANGUP
  892. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Callstate Change ACTIVE -> HANGUP
  893. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State HANGUP
  894. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] mod_sofia.c:407 sofia/internal/89031883186@sipproxy.telphin.ru:5060 Overriding SIP cause 480 with 200 from the other leg
  895. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] mod_sofia.c:413 Channel sofia/internal/89031883186@sipproxy.telphin.ru:5060 hanging up, cause: NORMAL_CLEARING
  896. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_ivr_bridge.c:1571 sofia/internal/89031883186@sipproxy.telphin.ru:5060 skip receive message [UNBRIDGE] (channel is hungup already)
  897. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_ivr_bridge.c:1574 sofia/internal/483*101@sipproxy.telphin.ru skip receive message [UNBRIDGE] (channel is hungup already)
  898. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_session.c:2767 sofia/internal/483*101@sipproxy.telphin.ru skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  899. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/483*101@sipproxy.telphin.ru) State EXECUTE going to sleep
  900. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/483*101@sipproxy.telphin.ru) Running State Change CS_HANGUP
  901. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] mod_sofia.c:465 Sending BYE to sofia/internal/89031883186@sipproxy.telphin.ru:5060
  902. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/483*101@sipproxy.telphin.ru) Callstate Change ACTIVE -> HANGUP
  903. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:60 sofia/internal/89031883186@sipproxy.telphin.ru:5060 Standard HANGUP, cause: NORMAL_CLEARING
  904. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State HANGUP going to sleep
  905. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State Change CS_HANGUP -> CS_REPORTING
  906. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  907. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Running State Change CS_REPORTING
  908. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/483*101@sipproxy.telphin.ru) State HANGUP
  909. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] mod_sofia.c:413 Channel sofia/internal/483*101@sipproxy.telphin.ru hanging up, cause: NORMAL_CLEARING
  910. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State REPORTING
  911. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:104 sofia/internal/89031883186@sipproxy.telphin.ru:5060 Standard REPORTING, cause: NORMAL_CLEARING
  912. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State REPORTING going to sleep
  913. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:498 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State Change CS_REPORTING -> CS_DESTROY
  914. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/89031883186@sipproxy.telphin.ru:5060 [BREAK]
  915. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_session.c:1624 Session 527446 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Locked, Waiting on external entities
  916. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [NOTICE] switch_core_session.c:1642 Session 527446 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Ended
  917. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [NOTICE] switch_core_session.c:1646 Close Channel sofia/internal/89031883186@sipproxy.telphin.ru:5060 [CS_DESTROY]
  918. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:60 sofia/internal/483*101@sipproxy.telphin.ru Standard HANGUP, cause: NORMAL_CLEARING
  919. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/483*101@sipproxy.telphin.ru) State HANGUP going to sleep
  920. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:626 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) Running State Change CS_DESTROY
  921. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/483*101@sipproxy.telphin.ru) State Change CS_HANGUP -> CS_REPORTING
  922. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  923. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State DESTROY
  924. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] mod_sofia.c:323 sofia/internal/89031883186@sipproxy.telphin.ru:5060 SOFIA DESTROY
  925. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:111 sofia/internal/89031883186@sipproxy.telphin.ru:5060 Standard DESTROY
  926. 67d32966-4d0a-11e6-8410-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/89031883186@sipproxy.telphin.ru:5060) State DESTROY going to sleep
  927. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/483*101@sipproxy.telphin.ru) Running State Change CS_REPORTING
  928. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/483*101@sipproxy.telphin.ru) State REPORTING
  929. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:104 sofia/internal/483*101@sipproxy.telphin.ru Standard REPORTING, cause: NORMAL_CLEARING
  930. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/483*101@sipproxy.telphin.ru) State REPORTING going to sleep
  931. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:498 (sofia/internal/483*101@sipproxy.telphin.ru) State Change CS_REPORTING -> CS_DESTROY
  932. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/483*101@sipproxy.telphin.ru [BREAK]
  933. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_session.c:1624 Session 527445 (sofia/internal/483*101@sipproxy.telphin.ru) Locked, Waiting on external entities
  934. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [NOTICE] switch_core_session.c:1642 Session 527445 (sofia/internal/483*101@sipproxy.telphin.ru) Ended
  935. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [NOTICE] switch_core_session.c:1646 Close Channel sofia/internal/483*101@sipproxy.telphin.ru [CS_DESTROY]
  936. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:626 (sofia/internal/483*101@sipproxy.telphin.ru) Running State Change CS_DESTROY
  937. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/483*101@sipproxy.telphin.ru) State DESTROY
  938. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] mod_sofia.c:323 sofia/internal/483*101@sipproxy.telphin.ru SOFIA DESTROY
  939. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:111 sofia/internal/483*101@sipproxy.telphin.ru Standard DESTROY
  940. 67cdaf36-4d0a-11e6-83d9-eb77bd4505f4 2016-07-18 20:09:46.596389 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/483*101@sipproxy.telphin.ru) State DESTROY going to sleep
  941.  
  942. 420a2e3c-4d0a-11e6-80bc-eb77bd4505f4 2016-07-18 20:09:48.576405 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:09:48.580153] SSRC[601823969]RTT[0.031128] A[2346488964] - DLSR[216850] - LSR[2346270074]
  943. 07446efc-4d0a-11e6-b938-eb77bd4505f4 2016-07-18 20:09:49.736412 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:09:49.755506] SSRC[462318916]RTT[0.034409] A[2346565992] - DLSR[250712] - LSR[2346313025]
  944. 66cdb3d8-4d0a-11e6-839e-eb77bd4505f4 2016-07-18 20:09:50.816386 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/144*102@sipproxy.telphin.ru:5060 [BREAK]
  945. 66cdb3d8-4d0a-11e6-839e-eb77bd4505f4 2016-07-18 20:09:50.816386 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/144*102@sipproxy.telphin.ru:5060 [BREAK]
  946. 66cdb3d8-4d0a-11e6-839e-eb77bd4505f4 2016-07-18 20:09:50.816386 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/144*102@sipproxy.telphin.ru:5060 [BREAK]
  947. 66cdb3d8-4d0a-11e6-839e-eb77bd4505f4 2016-07-18 20:09:50.836413 [DEBUG] sofia.c:6658 Channel sofia/internal/144*102@sipproxy.telphin.ru:5060 entering state [ready][200]
  948. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:09:50.836413 [DEBUG] switch_core_session.c:979 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [BREAK]
  949. 66cdb3d8-4d0a-11e6-839e-eb77bd4505f4 2016-07-18 20:09:50.836413 [DEBUG] switch_core_session.c:979 Send signal sofia/internal/144*102@sipproxy.telphin.ru:5060 [BREAK]
  950. 420a2e3c-4d0a-11e6-80bc-eb77bd4505f4 2016-07-18 20:09:53.816434 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:09:53.820191] SSRC[601823969]RTT[0.030106] A[2346832376] - DLSR[232649] - LSR[2346597754]
  951. 07446efc-4d0a-11e6-b938-eb77bd4505f4 2016-07-18 20:09:54.436388 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:09:54.455474] SSRC[462318916]RTT[0.041046] A[2346874009] - DLSR[230615] - LSR[2346640704]
  952. 420a2e3c-4d0a-11e6-80bc-eb77bd4505f4 2016-07-18 20:09:59.056382 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:09:59.60163] SSRC[601823969]RTT[0.030365] A[2347175782] - DLSR[248355] - LSR[2346925437]
  953. 07446efc-4d0a-11e6-b938-eb77bd4505f4 2016-07-18 20:09:59.136380 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:09:59.155515] SSRC[462318916]RTT[0.037567] A[2347182031] - DLSR[211187] - LSR[2346968382]
  954. 07446efc-4d0a-11e6-b938-eb77bd4505f4 2016-07-18 20:10:03.836425 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:10:03.855469] SSRC[462318916]RTT[0.034363] A[2347490048] - DLSR[191733] - LSR[2347296063]
  955. 420a2e3c-4d0a-11e6-80bc-eb77bd4505f4 2016-07-18 20:10:04.296399 [NOTICE] switch_rtp.c:5239 Receiving an RTCP packet[2016-18-06 17:10:04.300195] SSRC[601823969]RTT[0.030975] A[2347519193] - DLSR[264044] - LSR[2347253119]
  956. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [BREAK]
  957. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [NOTICE] sofia.c:952 Hangup sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  958. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_channel.c:3244 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [KILL]
  959. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [BREAK]
  960. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_ivr_bridge.c:665 BRIDGE THREAD DONE [sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060]
  961. 66cdb3d8-4d0a-11e6-839e-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_ivr_bridge.c:695 Send signal sofia/internal/144*102@sipproxy.telphin.ru:5060 [BREAK]
  962. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_core_state_machine.c:538 (sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060) State EXCHANGE_MEDIA going to sleep
  963. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060) Running State Change CS_HANGUP
  964. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060) Callstate Change ACTIVE -> HANGUP
  965. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060) State HANGUP
  966. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] mod_sofia.c:413 Channel sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 hanging up, cause: NORMAL_CLEARING
  967. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_core_state_machine.c:60 sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 Standard HANGUP, cause: NORMAL_CLEARING
  968. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060) State HANGUP going to sleep
  969. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060) State Change CS_HANGUP -> CS_REPORTING
  970. 66d25a64-4d0a-11e6-83d5-eb77bd4505f4 2016-07-18 20:10:07.436464 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/%2B79858832517@sipproxy.telphin.ru:5060 [BREAK]
  971.