1. span style="color: cornflowerblue; font-weight: bold;"> 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [NOTICE] switch_channel.c:1104 New Channel sofia/external/9185330000@45.55.163.124 [47ac4b3e-74e3-11e7-b726-c1f435f54e69]
2. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_NEW (Cur 1 Tot 176)
3. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] sofia.c:10067 sofia/external/9185330000@45.55.163.124 receiving invite from 45.55.163.124:5060 version: 1.9.0 git 144d373 2017-07-28 23:05:50Z 32bit
4. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] sofia.c:7283 Channel sofia/external/9185330000@45.55.163.124 entering state [received][100]
5. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] sofia.c:7293 Remote SDP:
6. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 v=0
7. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 o=yate 1501390516 1501390516 IN IP4 45.55.163.124
8. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 s=SIP Call
9. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 c=IN IP4 45.55.163.124
10. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 t=0 0
11. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 m=audio 24486 RTP/AVP 0 3 101
12. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:0 PCMU/8000
13. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:3 GSM/8000
14. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:101 telephone-event/8000
15. 47ac4b3e-74e3-11e7-b726-c1f435f54e69
16. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] sofia.c:7685 (sofia/external/9185330000@45.55.163.124) State Change CS_NEW -> CS_INIT
17. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:603 (sofia/external/9185330000@45.55.163.124) State NEW
18. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_INIT (Cur 1 Tot 176)
19. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:627 (sofia/external/9185330000@45.55.163.124) State INIT
20. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] mod_sofia.c:93 sofia/external/9185330000@45.55.163.124 SOFIA INIT
21. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:40 sofia/external/9185330000@45.55.163.124 Standard INIT
22. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:48 (sofia/external/9185330000@45.55.163.124) State Change CS_INIT -> CS_ROUTING
23. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:627 (sofia/external/9185330000@45.55.163.124) State INIT going to sleep
24. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_ROUTING (Cur 1 Tot 176)
25. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_channel.c:2249 (sofia/external/9185330000@45.55.163.124) Callstate Change DOWN -> RINGING
26. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:643 (sofia/external/9185330000@45.55.163.124) State ROUTING
27. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] mod_sofia.c:154 sofia/external/9185330000@45.55.163.124 SOFIA ROUTING
28. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [DEBUG] switch_core_state_machine.c:236 sofia/external/9185330000@45.55.163.124 Standard ROUTING
29. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.682441 [INFO] mod_dialplan_xml.c:637 Processing TULSA, OK <9185330000>->1121300000005740 in context public
30. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->unloop] continue=false
31. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
32. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
33. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->outside_call] continue=true
34. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Absolute Condition [outside_call]
35. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(outside_call=true)
36. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
37. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->call_debug] continue=true
38. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
39. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_extensions] continue=false
40. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [public_extensions] destination_number(1121300000005740) =~ /^(10[01][0-9])$/ break=on-false
41. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_did] continue=false
42. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [public_did] destination_number(1121300000005740) =~ /^15123330880$/ break=on-false
43. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_did] continue=false
44. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [public_did] destination_number(1121300000005740) =~ /^17023024016$/ break=on-false
45. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_did] continue=false
46. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [public_did] destination_number(1121300000005740) =~ /^883510009027723$/ break=on-false
47. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_did] continue=false
48. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [public_did] destination_number(1121300000005740) =~ /^\+12109412600$/ break=on-false
49. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [public->public_did] continue=false
50. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (PASS) [public_did] destination_number(1121300000005740) =~ /^1121300000005740$/ break=on-false
51. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(domain_name=192.168.0.137)
52. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action transfer(2001 XML default)
53. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:286 (sofia/external/9185330000@45.55.163.124) State Change CS_ROUTING -> CS_EXECUTE
54. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:643 (sofia/external/9185330000@45.55.163.124) State ROUTING going to sleep
55. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_EXECUTE (Cur 1 Tot 176)
56. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:650 (sofia/external/9185330000@45.55.163.124) State EXECUTE
57. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] mod_sofia.c:209 sofia/external/9185330000@45.55.163.124 SOFIA EXECUTE
58. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:328 sofia/external/9185330000@45.55.163.124 Standard EXECUTE
59. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(outside_call=true)
60. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [outside_call]=[true]
61. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 export(RFC2822_DATE=Sat, 29 Jul 2017 21:55:16 -0700)
62. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700]
63. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(domain_name=192.168.0.137)
64. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [domain_name]=[192.168.0.137]
65. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 transfer(2001 XML default)
66. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_ivr.c:2194 (sofia/external/9185330000@45.55.163.124) State Change CS_EXECUTE -> CS_ROUTING
67. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [NOTICE] switch_ivr.c:2201 Transfer sofia/external/9185330000@45.55.163.124 to XML[2001@default]
68. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:650 (sofia/external/9185330000@45.55.163.124) State EXECUTE going to sleep
69. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_ROUTING (Cur 1 Tot 176)
70. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:643 (sofia/external/9185330000@45.55.163.124) State ROUTING
71. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] mod_sofia.c:145 Call appears to be already acknowledged
72. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] mod_sofia.c:154 sofia/external/9185330000@45.55.163.124 SOFIA ROUTING
73. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [DEBUG] switch_core_state_machine.c:236 sofia/external/9185330000@45.55.163.124 Standard ROUTING
74. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.702479 [INFO] mod_dialplan_xml.c:637 Processing TULSA, OK <9185330000>->2001 in context default
75. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->unloop] continue=false
76. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
77. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
78. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->tod_example] continue=true
79. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Date/TimeMatch (FAIL) [tod_example] break=on-false
80. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->holiday_example] continue=true
81. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Date/TimeMatch (FAIL) [holiday_example] break=on-false
82. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->global-intercept] continue=false
83. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [global-intercept] destination_number(2001) =~ /^886$/ break=on-false
84. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->group-intercept] continue=false
85. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [group-intercept] destination_number(2001) =~ /^\*8$/ break=on-false
86. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->intercept-ext] continue=false
87. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [intercept-ext] destination_number(2001) =~ /^\*\*(\d+)$/ break=on-false
88. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->redial] continue=false
89. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [redial] destination_number(2001) =~ /^(redial|870)$/ break=on-false
90. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->global] continue=true
91. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
92. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [global] ${default_password}() =~ /^1234$/ break=never
93. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never
94. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
95. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [global] ${switch_r_sdp}(v=0
96. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 o=yate 1501390516 1501390516 IN IP4 45.55.163.124
97. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 s=SIP Call
98. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 c=IN IP4 45.55.163.124
99. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 t=0 0
100. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 m=audio 24486 RTP/AVP 0 3 101
101. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:0 PCMU/8000
102. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:3 GSM/8000
103. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:101 telephone-event/8000
104. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
105. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Absolute Condition [global]
106. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
107. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
108. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action hash(insert/${domain_name}-last_dial/global/${uuid})
109. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
110. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->snom-demo-2] continue=false
111. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [snom-demo-2] destination_number(2001) =~ /^9001$/ break=on-false
112. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->snom-demo-1] continue=false
113. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [snom-demo-1] destination_number(2001) =~ /^9000$/ break=on-false
114. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->eavesdrop] continue=false
115. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [eavesdrop] destination_number(2001) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
116. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->eavesdrop] continue=false
117. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [eavesdrop] destination_number(2001) =~ /^779$/ break=on-false
118. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->call_return] continue=false
119. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [call_return] destination_number(2001) =~ /^\*69$|^869$|^lcr$/ break=on-false
120. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->del-group] continue=false
121. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [del-group] destination_number(2001) =~ /^80(\d{2})$/ break=on-false
122. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->add-group] continue=false
123. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [add-group] destination_number(2001) =~ /^81(\d{2})$/ break=on-false
124. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->call-group-simo] continue=false
125. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [call-group-simo] destination_number(2001) =~ /^82(\d{2})$/ break=on-false
126. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->call-group-order] continue=false
127. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [call-group-order] destination_number(2001) =~ /^83(\d{2})$/ break=on-false
128. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->extension-intercom] continue=false
129. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [extension-intercom] destination_number(2001) =~ /^8(10[01][0-9])$/ break=on-false
130. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->Local_Extension] continue=false
131. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [Local_Extension] destination_number(2001) =~ /^(26[01][0-9]|phone|mobile)$/ break=on-false
132. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->Local_Extension_Skinny] continue=false
133. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [Local_Extension_Skinny] destination_number(2001) =~ /^(11[01][0-9])$/ break=on-false
134. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->group_dial_sales] continue=false
135. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (FAIL) [group_dial_sales] destination_number(2001) =~ /^2000$/ break=on-false
136. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 parsing [default->group_dial_support] continue=false
137. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Regex (PASS) [group_dial_support] destination_number(2001) =~ /^2001$/ break=on-false
138. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(ringback=local_stream://custom)
139. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action playback({timeout=6000})
140. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(call_timeout=20)
141. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(continue_on_fail=true)
142. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action set(hangup_after_bridge=true)
143. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action bridge({ignore_early_media=true}group/support@${domain_name})
144. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action answer()
145. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action sleep(2000)
146. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 Dialplan: sofia/external/9185330000@45.55.163.124 Action voicemail(default ${domain_name} 2600)
147. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_state_machine.c:286 (sofia/external/9185330000@45.55.163.124) State Change CS_ROUTING -> CS_EXECUTE
148. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_state_machine.c:643 (sofia/external/9185330000@45.55.163.124) State ROUTING going to sleep
149. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_EXECUTE (Cur 1 Tot 176)
150. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_state_machine.c:650 (sofia/external/9185330000@45.55.163.124) State EXECUTE
151. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] mod_sofia.c:209 sofia/external/9185330000@45.55.163.124 SOFIA EXECUTE
152. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_state_machine.c:328 sofia/external/9185330000@45.55.163.124 Standard EXECUTE
153. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 hash(insert/192.168.0.137-spymap/9185330000/47ac4b3e-74e3-11e7-b726-c1f435f54e69)
154. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 hash(insert/192.168.0.137-last_dial/9185330000/2001)
155. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 hash(insert/192.168.0.137-last_dial/global/47ac4b3e-74e3-11e7-b726-c1f435f54e69)
156. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 export(RFC2822_DATE=Sat, 29 Jul 2017 21:55:16 -0700)
157. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700]
158. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(ringback=local_stream://custom)
159. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [ringback]=[local_stream://custom]
160. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_session.c:2708 Application playback Requires media! pre_answering channel sofia/external/9185330000@45.55.163.124
161. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [INFO] switch_core_session.c:2710 Sending early media
162. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
163. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
164. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
165. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5170 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
166. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
167. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [GSM:3:8000:20:13200:1]/[opus:116:48000:20:0:1]
168. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G722:9:8000:20:64000:1]
169. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
170. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5115 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
171. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5031 Set telephone-event payload to 101@8000
172. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:3430 Set Codec sofia/external/9185330000@45.55.163.124 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
173. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_codec.c:111 sofia/external/9185330000@45.55.163.124 Original read codec set to PCMU:0
174. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5374 Set telephone-event payload to 101@8000
175. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.722494 [DEBUG] switch_core_media.c:5432 sofia/external/9185330000@45.55.163.124 Set 2833 dtmf send payload to 101 recv payload to 101
176. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_core_media.c:8149 AUDIO RTP [sofia/external/9185330000@45.55.163.124] 192.168.0.137 port 18342 -> 45.55.163.124 port 24486 codec: 0 ms: 20
177. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_rtp.c:4164 Starting timer [soft] 160 bytes per 20ms
178. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_core_media.c:8452 sofia/external/9185330000@45.55.163.124 Set 2833 dtmf send payload to 101
179. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_core_media.c:8459 sofia/external/9185330000@45.55.163.124 Set 2833 dtmf receive payload to 101
180. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_core_media.c:8482 sofia/external/9185330000@45.55.163.124 Set rtp dtmf delay to 40
181. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/9185330000@45.55.163.124!
182. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_channel.c:3482 (sofia/external/9185330000@45.55.163.124) Callstate Change RINGING -> EARLY
183. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] switch_core_media.c:8132 Audio params are unchanged for sofia/external/9185330000@45.55.163.124.
184. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] mod_sofia.c:2512 Ring SDP:
185. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 v=0
186. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 o=FreeSWITCH 1501372174 1501372175 IN IP4 freeswitch.example.com
187. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 s=FreeSWITCH
188. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 c=IN IP4 freeswitch.example.com
189. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 t=0 0
190. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 m=audio 18342 RTP/AVP 0 101
191. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:0 PCMU/8000
192. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:101 telephone-event/8000
193. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=fmtp:101 0-16
194. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=ptime:20
195. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=sendrecv
196. 47ac4b3e-74e3-11e7-b726-c1f435f54e69
197. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 playback({timeout=6000})
198. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.862450 [DEBUG] sofia.c:7283 Channel sofia/external/9185330000@45.55.163.124 entering state [early][183]
199. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(call_timeout=20)
200. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [call_timeout]=[20]
201. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(continue_on_fail=true)
202. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [continue_on_fail]=[true]
203. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 set(hangup_after_bridge=true)
204. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] mod_dptools.c:1588 SET sofia/external/9185330000@45.55.163.124 [hangup_after_bridge]=[true]
205. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 EXECUTE sofia/external/9185330000@45.55.163.124 bridge({ignore_early_media=true}group/support@192.168.0.137)
206. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] switch_channel.c:1250 sofia/external/9185330000@45.55.163.124 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700] to event
207. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] switch_channel.c:1250 sofia/external/9185330000@45.55.163.124 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700] to event
208. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.882464 [DEBUG] switch_ivr_originate.c:2147 Parsing global variables
209. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_channel.c:1250 sofia/external/9185330000@45.55.163.124 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700] to event
210. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_channel.c:1250 sofia/external/9185330000@45.55.163.124 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 29 Jul 2017 21:55:16 -0700] to event
211. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2147 Parsing global variables
212. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
213. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
214. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [NOTICE] switch_ivr_originate.c:2856 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
215. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
216. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [NOTICE] switch_ivr_originate.c:2856 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
217. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
218. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [NOTICE] switch_ivr_originate.c:2856 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
219. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
220. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [DEBUG] switch_ivr_originate.c:2674 Parsing session specific variables
221. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:16.902561 [NOTICE] switch_ivr_originate.c:2856 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
222. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:17.062449 [DEBUG] switch_ivr_originate.c:1278 Raw Codec Activation Success L16@8000hz 1 channel 20ms
223. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:17.062449 [DEBUG] switch_core_codec.c:223 sofia/external/9185330000@45.55.163.124 Push codec L16:100
224. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:17.062449 [DEBUG] switch_ivr_originate.c:1310 Play Ringback File [local_stream://custom]
225. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] switch_core_codec.c:248 sofia/external/9185330000@45.55.163.124 Restore previous codec PCMU:0.
226. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] switch_core_media.c:8132 Audio params are unchanged for sofia/external/9185330000@45.55.163.124.
227. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] mod_sofia.c:881 Local SDP sofia/external/9185330000@45.55.163.124:
228. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 v=0
229. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 o=FreeSWITCH 1501372174 1501372176 IN IP4 freeswitch.example.com
230. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 s=FreeSWITCH
231. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 c=IN IP4 freeswitch.example.com
232. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 t=0 0
233. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 m=audio 18342 RTP/AVP 0 101
234. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:0 PCMU/8000
235. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=rtpmap:101 telephone-event/8000
236. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=fmtp:101 0-16
237. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=ptime:20
238. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 a=sendrecv
239. 47ac4b3e-74e3-11e7-b726-c1f435f54e69
240. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [NOTICE] switch_ivr_originate.c:3652 Channel [sofia/external/9185330000@45.55.163.124] has been answered
241. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] switch_channel.c:3781 (sofia/external/9185330000@45.55.163.124) Callstate Change EARLY -> ACTIVE
242. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] sofia.c:7283 Channel sofia/external/9185330000@45.55.163.124 entering state [completed][200]
243. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.902480 [DEBUG] switch_ivr_originate.c:3710 Originate Resulted in Success: [sofia/internal/2600@192.168.0.12]
244. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:18.922489 [DEBUG] switch_ivr_originate.c:3710 Originate Resulted in Success: [sofia/internal/2600@192.168.0.12]
245. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.142441 [DEBUG] sofia.c:7283 Channel sofia/external/9185330000@45.55.163.124 entering state [ready][200]
246. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.282437 [NOTICE] sofia.c:1079 Hangup sofia/external/9185330000@45.55.163.124 [CS_EXECUTE] [NORMAL_CLEARING]
247. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/external/9185330000@45.55.163.124]
248. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_ivr_bridge.c:1846 sofia/external/9185330000@45.55.163.124 skip receive message [TRANSFER] (channel is hungup already)
249. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_session.c:2885 sofia/external/9185330000@45.55.163.124 skip receive message [PHONE_EVENT] (channel is hungup already)
250. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:650 (sofia/external/9185330000@45.55.163.124) State EXECUTE going to sleep
251. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_HANGUP (Cur 2 Tot 178)
252. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:850 (sofia/external/9185330000@45.55.163.124) Callstate Change ACTIVE -> HANGUP
253. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:852 (sofia/external/9185330000@45.55.163.124) State HANGUP
254. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] mod_sofia.c:449 Channel sofia/external/9185330000@45.55.163.124 hanging up, cause: NORMAL_CLEARING
255. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:60 sofia/external/9185330000@45.55.163.124 Standard HANGUP, cause: NORMAL_CLEARING
256. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:852 (sofia/external/9185330000@45.55.163.124) State HANGUP going to sleep
257. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:619 (sofia/external/9185330000@45.55.163.124) State Change CS_HANGUP -> CS_REPORTING
258. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:584 (sofia/external/9185330000@45.55.163.124) Running State Change CS_REPORTING (Cur 2 Tot 178)
259. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.302459 [DEBUG] switch_core_state_machine.c:938 (sofia/external/9185330000@45.55.163.124) State REPORTING
260. "2017-07-29 21:55:19",3, 0, 1,"NORMAL_CLEARING","47ac4b3e-74e3-11e7-b726-c1f435f54e69","47ccf19a-74e3-11e7-b73b-c1f435f54e69","","PCMU","PCMU",
261. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_state_machine.c:174 sofia/external/9185330000@45.55.163.124 Standard REPORTING, cause: NORMAL_CLEARING
262. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_state_machine.c:938 (sofia/external/9185330000@45.55.163.124) State REPORTING going to sleep
263. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_state_machine.c:610 (sofia/external/9185330000@45.55.163.124) State Change CS_REPORTING -> CS_DESTROY
264. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_session.c:1713 Session 176 (sofia/external/9185330000@45.55.163.124) Locked, Waiting on external entities
265. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [NOTICE] switch_core_session.c:1731 Session 176 (sofia/external/9185330000@45.55.163.124) Ended
266. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [NOTICE] switch_core_session.c:1735 Close Channel sofia/external/9185330000@45.55.163.124 [CS_DESTROY]
267. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_state_machine.c:741 (sofia/external/9185330000@45.55.163.124) Running State Change CS_DESTROY (Cur 0 Tot 178)
268. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] switch_core_state_machine.c:751 (sofia/external/9185330000@45.55.163.124) State DESTROY
269. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.322454 [DEBUG] mod_sofia.c:354 sofia/external/9185330000@45.55.163.124 SOFIA DESTROY
270. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.482441 [DEBUG] switch_core_state_machine.c:181 sofia/external/9185330000@45.55.163.124 Standard DESTROY
271. 47ac4b3e-74e3-11e7-b726-c1f435f54e69 2017-07-29 21:55:19.482441 [DEBUG] switch_core_state_machine.c:751 (sofia/external/9185330000@45.55.163.124) State DESTROY going to sleep
272.