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.