1. +OK log level  [7]
2. freeswitch@internal> sofia global siptrace on
3. +OK Global siptrace on
4. recv 1188 bytes from udp/[64.7.96.3]:5060 at 03:05:04.499268:
5.    ------------------------------------------------------------------------
6.    INVITE sip:6303437370@64.7.99.27:5080 SIP/2.0
7.    Record-Route: <sip:64.7.96.3;lr=on;ftag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388;mp=yes;vsf=AAAAAAEACAB4AQYeDh55ABoYNy45Ni4z>
8.    Via: SIP/2.0/UDP 64.7.96.3;branch=z9hG4bKfe59.feb100c6.0
9.    Via: SIP/2.0/UDP 64.7.96.6:5060;branch=z9hG4bK194a11786434f
10.    From: "Brent Sachnoff" <sip:7086872090@64.7.96.3>;tag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388
11.    To: <sip:16303437370@64.7.96.3>
12.    Date: Wed, 11 May 2016 08:05:04 GMT
13.    Call-ID: ffe3d80-7321e7b0-bfc3-6600740@64.7.96.6
14.    Supported: timer,replaces
15.    Min-SE:  1800
16.    User-Agent: Cisco-CCM5.1
17.   Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY
18.    CSeq: 101 INVITE
19.    Contact: <sip:6006@64.7.96.6:5060>
20.    Expires: 180
21.    Allow-Events: presence, kpml
22.    Call-Info: <sip:64.7.96.6:5060>;method="NOTIFY;Event=telephone-event;Duration=500"
23.    Session-Expires:  1800
24.    Max-Forwards: 69
25.    Content-Type: application/sdp
26.    Content-Length: 206
27.    P-hint: mediaproxy applied
28.    
29.    v=0
30.    o=CiscoSystemsCCM-SIP 2000 1 IN IP4 64.7.96.6
31.    s=SIP Call
32.    c=IN IP4 64.7.96.3
33.    t=0 0
34.    m=audio 44250 RTP/AVP 0 101
35.    a=rtpmap:0 PCMU/8000
36.    a=ptime:20
37.    a=rtpmap:101 telephone-event/8000
38.    a=fmtp:101 0-15
39.    ------------------------------------------------------------------------
40. send 518 bytes to udp/[64.7.96.3]:5060 at 03:05:04.499627:
41.    ------------------------------------------------------------------------
42.    SIP/2.0 100 Trying
43.    Via: SIP/2.0/UDP 64.7.96.3;branch=z9hG4bKfe59.feb100c6.0
44.    Via: SIP/2.0/UDP 64.7.96.6:5060;branch=z9hG4bK194a11786434f
45.    Record-Route: <sip:64.7.96.3;lr=on;ftag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388;mp=yes;vsf=AAAAAAEACAB4AQYeDh55ABoYNy45Ni4z>
46.    From: "Brent Sachnoff" <sip:7086872090@64.7.96.3>;tag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388
47.    To: <sip:16303437370@64.7.96.3>
48.    Call-ID: ffe3d80-7321e7b0-bfc3-6600740@64.7.96.6
49.    CSeq: 101 INVITE
50.    User-Agent: FreeSWITCH
51.    Content-Length: 0
52.    
53.    ------------------------------------------------------------------------
54. 2016-05-11 03:05:04.480940 [NOTICE] switch_channel.c:1101 New Channel sofia/external/7086872090@64.7.96.3 [11828066-174f-11e6-b94d-8dcc9e1d3d65]
55. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_state_machine.c:473 (sofia/external/7086872090@64.7.96.3) Running State Change CS_NEW
56. 2016-05-11 03:05:04.480940 [DEBUG] sofia.c:9248 sofia/external/7086872090@64.7.96.3 receiving invite from 64.7.96.3:5060 version: 1.6.6  64bit
57. 2016-05-11 03:05:04.480940 [DEBUG] sofia.c:6760 Channel sofia/external/7086872090@64.7.96.3 entering state [received][100]
58. 2016-05-11 03:05:04.480940 [DEBUG] sofia.c:6770 Remote SDP:
59. v=0
60. o=CiscoSystemsCCM-SIP 2000 1 IN IP4 64.7.96.6
61. s=SIP Call
62. c=IN IP4 64.7.96.3
63. t=0 0
64. m=audio 44250 RTP/AVP 0 101
65. a=rtpmap:0 PCMU/8000
66. a=rtpmap:101 telephone-event/8000
67. a=fmtp:101 0-15
68. a=ptime:20
69.  
70. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_media.c:4161 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G7221:115:32000:20:48000:1]
71. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_media.c:4161 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G7221:107:16000:20:32000:1]
72. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_media.c:4161 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
73. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_media.c:4161 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
74. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_media.c:4216 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
75. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_media.c:4161 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
76. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_media.c:4161 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
77. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_media.c:4077 Set telephone-event payload to 101@8000
78. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_media.c:2906 Set Codec sofia/external/7086872090@64.7.96.3 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
79. 2016-05-11 03:05:04.480940 [DEBUG] switch_core_codec.c:111 sofia/external/7086872090@64.7.96.3 Original read codec set to PCMU:0
80. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_media.c:4429 Set telephone-event payload to 101@8000
81. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_media.c:4485 sofia/external/7086872090@64.7.96.3 Set 2833 dtmf send payload to 101 recv payload to 101
82. 2016-05-11 03:05:04.500922 [DEBUG] sofia.c:7146 (sofia/external/7086872090@64.7.96.3) State Change CS_NEW -> CS_INIT
83. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:492 (sofia/external/7086872090@64.7.96.3) State NEW
84. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:473 (sofia/external/7086872090@64.7.96.3) Running State Change CS_INIT
85. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:516 (sofia/external/7086872090@64.7.96.3) State INIT
86. 2016-05-11 03:05:04.500922 [DEBUG] mod_sofia.c:88 sofia/external/7086872090@64.7.96.3 SOFIA INIT
87. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:40 sofia/external/7086872090@64.7.96.3 Standard INIT
88. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:48 (sofia/external/7086872090@64.7.96.3) State Change CS_INIT -> CS_ROUTING
89. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:516 (sofia/external/7086872090@64.7.96.3) State INIT going to sleep
90. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:473 (sofia/external/7086872090@64.7.96.3) Running State Change CS_ROUTING
91. 2016-05-11 03:05:04.500922 [DEBUG] switch_channel.c:2247 (sofia/external/7086872090@64.7.96.3) Callstate Change DOWN -> RINGING
92. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:532 (sofia/external/7086872090@64.7.96.3) State ROUTING
93. 2016-05-11 03:05:04.500922 [DEBUG] mod_sofia.c:141 sofia/external/7086872090@64.7.96.3 SOFIA ROUTING
94. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:166 sofia/external/7086872090@64.7.96.3 Standard ROUTING
95. 2016-05-11 03:05:04.500922 [INFO] mod_dialplan_xml.c:637 Processing Brent Sachnoff <7086872090>->6303437370 in context public
96. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [public->6303437370] continue=false
97. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [6303437370] destination_number(6303437370) =~ /6303437370/ break=on-false
98. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(call_direction=inbound)
99. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(domain_uuid=fc116b59-2402-4d62-8111-268fcc26951c)
100. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(domain_name=besindustries.urbancom.net)
101. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(domain=besindustries.urbancom.net)
102. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(effective_caller_id_name=Brent Sachnoff#${caller_id_name})
103. Dialplan: sofia/external/7086872090@64.7.96.3 Action transfer(1001 XML besindustries.urbancom.net)
104. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:216 (sofia/external/7086872090@64.7.96.3) State Change CS_ROUTING -> CS_EXECUTE
105. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:532 (sofia/external/7086872090@64.7.96.3) State ROUTING going to sleep
106. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:473 (sofia/external/7086872090@64.7.96.3) Running State Change CS_EXECUTE
107. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:539 (sofia/external/7086872090@64.7.96.3) State EXECUTE
108. 2016-05-11 03:05:04.500922 [DEBUG] mod_sofia.c:196 sofia/external/7086872090@64.7.96.3 SOFIA EXECUTE
109. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:258 sofia/external/7086872090@64.7.96.3 Standard EXECUTE
110. EXECUTE sofia/external/7086872090@64.7.96.3 set(call_direction=inbound)
111. 2016-05-11 03:05:04.500922 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [call_direction]=[inbound]
112. EXECUTE sofia/external/7086872090@64.7.96.3 set(domain_uuid=fc116b59-2402-4d62-8111-268fcc26951c)
113. 2016-05-11 03:05:04.500922 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [domain_uuid]=[fc116b59-2402-4d62-8111-268fcc26951c]
114. EXECUTE sofia/external/7086872090@64.7.96.3 set(domain_name=besindustries.urbancom.net)
115. 2016-05-11 03:05:04.500922 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [domain_name]=[besindustries.urbancom.net]
116. EXECUTE sofia/external/7086872090@64.7.96.3 set(domain=besindustries.urbancom.net)
117. 2016-05-11 03:05:04.500922 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [domain]=[besindustries.urbancom.net]
118. EXECUTE sofia/external/7086872090@64.7.96.3 set(effective_caller_id_name=Brent Sachnoff#Brent Sachnoff)
119. span style="color: goldenrod; font-weight: bold;"> 2016-05-11 03:05:04.500922 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [effective_caller_id_name]=[Brent Sachnoff#Brent Sachnoff]
120. EXECUTE sofia/external/7086872090@64.7.96.3 transfer(1001 XML besindustries.urbancom.net)
121. 2016-05-11 03:05:04.500922 [DEBUG] switch_ivr.c:2085 (sofia/external/7086872090@64.7.96.3) State Change CS_EXECUTE -> CS_ROUTING
122. 2016-05-11 03:05:04.500922 [NOTICE] switch_ivr.c:2092 Transfer sofia/external/7086872090@64.7.96.3 to XML[1001@besindustries.urbancom.net]
123. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:539 (sofia/external/7086872090@64.7.96.3) State EXECUTE going to sleep
124. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:473 (sofia/external/7086872090@64.7.96.3) Running State Change CS_ROUTING
125. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:532 (sofia/external/7086872090@64.7.96.3) State ROUTING
126. 2016-05-11 03:05:04.500922 [DEBUG] mod_sofia.c:141 sofia/external/7086872090@64.7.96.3 SOFIA ROUTING
127. 2016-05-11 03:05:04.500922 [DEBUG] switch_core_state_machine.c:166 sofia/external/7086872090@64.7.96.3 Standard ROUTING
128. 2016-05-11 03:05:04.500922 [INFO] mod_dialplan_xml.c:637 Processing Brent Sachnoff <7086872090>->1001 in context besindustries.urbancom.net
129. 2016-05-11 03:05:04.520899 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fb250041150 Connected.
130. 2016-05-11 03:05:04.580899 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7fb250041150 released.
131. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->user_exists] continue=true
132. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [user_exists] () =~ // break=on-false
133. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
134. EXECUTE sofia/external/7086872090@64.7.96.3 set(user_exists=true)
135. 2016-05-11 03:05:04.580899 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [user_exists]=[true]
136. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [user_exists] ${user_exists}(true) =~ /^true$/ break=on-false
137. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(extension_uuid=${user_data ${destination_number}@${domain_name} var extension_uuid})
138. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(hold_music=${user_data ${destination_number}@${domain_name} var hold_music})
139. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled})
140. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(forward_all_destination=${user_data ${destination_number}@${domain_name} var forward_all_destination})
141. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(forward_busy_enabled=${user_data ${destination_number}@${domain_name} var forward_busy_enabled})
142. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(forward_busy_destination=${user_data ${destination_number}@${domain_name} var forward_busy_destination})
143. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(forward_no_answer_enabled=${user_data ${destination_number}@${domain_name} var forward_no_answer_enabled})
144. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(forward_no_answer_destination=${user_data ${destination_number}@${domain_name} var forward_no_answer_destination})
145. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(forward_user_not_registered_enabled=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_enabled})
146. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(forward_user_not_registered_destination=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_destination})
147. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(do_not_disturb=${user_data ${destination_number}@${domain_name} var do_not_disturb})
148. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(call_timeout=${user_data ${destination_number}@${domain_name} var call_timeout})
149. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(missed_call_app=${user_data ${destination_number}@${domain_name} var missed_call_app})
150. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(missed_call_data=${user_data ${destination_number}@${domain_name} var missed_call_data})
151. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(call_screen_enabled=${user_data ${destination_number}@${domain_name} var call_screen_enabled}) INLINE
152. EXECUTE sofia/external/7086872090@64.7.96.3 set(call_screen_enabled=)
153. 2016-05-11 03:05:04.600915 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [call_screen_enabled]=[UNDEF]
154. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->call-direction] continue=true
155. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never
156. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [call-direction] ${user_exists}(true) =~ /^false$/ break=on-false
157. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->variables] continue=true
158. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [variables] () =~ // break=on-false
159. Dialplan: sofia/external/7086872090@64.7.96.3 Action export(origination_callee_id_name=${destination_number})
160. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
161. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->user_record] continue=true
162. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [user_record] () =~ // break=on-false
163. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
164. EXECUTE sofia/external/7086872090@64.7.96.3 set(user_record=)
165. 2016-05-11 03:05:04.600915 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [user_record]=[UNDEF]
166. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
167. 2016-05-11 03:05:04.600915 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fb250041150 Connected.
168. 2016-05-11 03:05:04.600915 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7fb250041150 released.
169. EXECUTE sofia/external/7086872090@64.7.96.3 set(from_user_exists=false)
170. 2016-05-11 03:05:04.600915 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [from_user_exists]=[false]
171. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
172. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
173. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
174. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
175. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
176. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
177. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
178. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
179. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
180. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
181. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
182. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
183. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
184. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
185. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
186. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
187. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
188. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
189. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
190. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
191. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
192. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
193. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
194. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
195. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->redial] continue=true
196. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [redial] destination_number(1001) =~ /^(redial|\*870)$/ break=on-true
197. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [redial] () =~ // break=never
198. Dialplan: sofia/external/7086872090@64.7.96.3 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
199. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->sip.urbancom.net.11d] continue=false
200. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [sip.urbancom.net.11d] destination_number(1001) =~ /^\+?(\d{11})$/ break=on-false
201. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->agent_status] continue=false
202. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [agent_status] destination_number(1001) =~ /^\*22$/ break=on-false
203. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->agent_status_id] continue=false
204. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [agent_status_id] destination_number(1001) =~ /^\*23$/ break=on-false
205. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->group-intercept] continue=false
206. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [group-intercept] destination_number(1001) =~ /^\*8$/ break=on-false
207. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->page-extension] continue=false
208. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [page-extension] destination_number(1001) =~ /^\*8(\d{2,7})$/ break=on-false
209. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->eavesdrop] continue=false
210. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^\*33(\d{2,7})$/ break=on-false
211. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->call_privacy] continue=false
212. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [call_privacy] destination_number(1001) =~ /^\*67(\d+)$/ break=on-false
213. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->call_return] continue=false
214. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [call_return] destination_number(1001) =~ /^\*69$/ break=on-false
215. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->extension_queue] continue=
216. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [extension_queue] destination_number(1001) =~ /^\*800(.*)$/ break=on-false
217. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->intercept-ext] continue=false
218. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [intercept-ext] destination_number(1001) =~ /^\*\*(\d+)$/ break=on-false
219. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->intercept-ext-polycom] continue=false
220. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [intercept-ext-polycom] destination_number(1001) =~ /^\*97(\d+)$/ break=on-false
221. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->dx] continue=false
222. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [dx] destination_number(1001) =~ /^dx$/ break=on-false
223. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->att_xfer] continue=false
224. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [att_xfer] destination_number(1001) =~ /^att_xfer$/ break=on-false
225. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->extension-to-voicemail] continue=false
226. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [extension-to-voicemail] username(7086872090) =~ /^7086872090$/ break=on-false
227. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [extension-to-voicemail] destination_number(1001) =~ /^7086872090$/ break=on-false
228. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->send_to_voicemail] continue=false
229. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [send_to_voicemail] destination_number(1001) =~ /^\*99(\d{2,7})$/ break=on-false
230. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->vmain] continue=false
231. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [vmain] destination_number(1001) =~ /^vmain$|^\*4000$|^\*98$/ break=on-false
232. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->xfer_vm] continue=false
233. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [xfer_vm] destination_number(1001) =~ /^xfer_vm$/ break=on-false
234. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->is_transfer] continue=false
235. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [is_transfer] destination_number(1001) =~ /^is_transfer$/ break=on-false
236. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->vmain_user] continue=false
237. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [vmain_user] destination_number(1001) =~ /^\*97$/ break=on-false
238. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->cf] continue=false
239. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [cf] destination_number(1001) =~ /^cf$/ break=on-false
240. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->delay_echo] continue=false
241. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [delay_echo] destination_number(1001) =~ /^\*9195$/ break=on-false
242. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->echo] continue=false
243. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [echo] destination_number(1001) =~ /^\*9196$/ break=on-false
244. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->is_zrtp_secure] continue=true
245. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false
246. Dialplan: sofia/external/7086872090@64.7.96.3 ANTI-Action eval(not_secure)
247. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->milliwatt] continue=false
248. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [milliwatt] destination_number(1001) =~ /^\*9197$/ break=on-false
249. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->is_secure] continue=true
250. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [is_secure] ${sip_via_protocol}(udp) =~ /tls/ break=on-false
251. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->tone_stream] continue=false
252. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [tone_stream] destination_number(1001) =~ /^\*9198$/ break=on-false
253. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->hold_music] continue=false
254. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [hold_music] destination_number(1001) =~ /^\*9664$/ break=on-false
255. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->recordings] continue=false
256. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [recordings] destination_number(1001) =~ /^\*(732)$/ break=on-false
257. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->directory] continue=false
258. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [directory] destination_number(1001) =~ /^\*411$/ break=on-false
259. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->wake-up] continue=false
260. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [wake-up] destination_number(1001) =~ /^\*(925)$/ break=on-false
261. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->valet_park] continue=false
262. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [valet_park] destination_number(1001) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=never
263. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip:(.*)@.*/ break=never
264. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [valet_park] destination_number(1001) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=never
265. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [valet_park] destination_number(1001) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=on-false
266. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->operator] continue=false
267. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [operator] destination_number(1001) =~ /^0$|^operator$/ break=on-false
268. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->operator-forward] continue=false
269. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [operator-forward] destination_number(1001) =~ /^\*000$/ break=on-false
270. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->do-not-disturb] continue=false
271. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [do-not-disturb] destination_number(1001) =~ /^\*78$|\*363$/ break=on-true
272. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [do-not-disturb] destination_number(1001) =~ /^\*79$/ break=on-false
273. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->call-forward] continue=false
274. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [call-forward] destination_number(1001) =~ /^\*72$/ break=on-true
275. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [call-forward] destination_number(1001) =~ /^\*73$/ break=on-true
276. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [call-forward] destination_number(1001) =~ /^\*74$/ break=on-true
277. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->follow-me] continue=false
278. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [follow-me] destination_number(1001) =~ /^\*21$/ break=on-false
279. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->clear_sip_auto_answer] continue=true
280. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [clear_sip_auto_answer] ${click_to_call}() =~ /true/ break=on-false
281. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->call_screen] continue=true
282. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [call_screen] ${call_screen_enabled}() =~ /^true$/ break=on-false
283. Dialplan: sofia/external/7086872090@64.7.96.3 parsing [besindustries.urbancom.net->local_extension] continue=false
284. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [local_extension] ${user_exists}(true) =~ /true/ break=on-false
285. Dialplan: sofia/external/7086872090@64.7.96.3 Action export(dialed_extension=${destination_number}) INLINE
286. EXECUTE sofia/external/7086872090@64.7.96.3 export(dialed_extension=1001)
287. 2016-05-11 03:05:04.600915 [DEBUG] switch_channel.c:1293 EXPORT (export_vars) [dialed_extension]=[1001]
288. Dialplan: sofia/external/7086872090@64.7.96.3 Action limit(hash ${domain_name} ${destination_number} ${limit_max} ${limit_destination})
289. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (FAIL) [local_extension] ${sip_authorized}() =~ /true/ break=never
290. Dialplan: sofia/external/7086872090@64.7.96.3 ANTI-Action set(bind_target=both) INLINE
291. EXECUTE sofia/external/7086872090@64.7.96.3 set(bind_target=both)
292. 2016-05-11 03:05:04.600915 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [bind_target]=[both]
293. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [local_extension] () =~ // break=on-false
294. Dialplan: sofia/external/7086872090@64.7.96.3 Action bind_digit_action(local,*1,exec:execute_extension,dx XML ${context},${bind_target})
295. Dialplan: sofia/external/7086872090@64.7.96.3 Action bind_digit_action(local,*2,exec:record_session,${recordings_dir}/${domain_name}/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${uuid}.${record_ext},${bind_target})
296. Dialplan: sofia/external/7086872090@64.7.96.3 Action bind_digit_action(local,*3,exec:execute_extension,cf XML ${context},${bind_target})
297. Dialplan: sofia/external/7086872090@64.7.96.3 Action bind_digit_action(local,*4,exec:execute_extension,att_xfer XML ${context},${bind_target})
298. Dialplan: sofia/external/7086872090@64.7.96.3 Action digit_action_set_realm(local)
299. Dialplan: sofia/external/7086872090@64.7.96.3 Regex (PASS) [local_extension] () =~ // break=on-false
300. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(hangup_after_bridge=true)
301. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(continue_on_fail=true)
302. Dialplan: sofia/external/7086872090@64.7.96.3 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
303. Dialplan: sofia/external/7086872090@64.7.96.3 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
304. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(called_party_call_group=${user_data(${dialed_extension}@${domain_name} var call_group)})
305. Dialplan: sofia/external/7086872090@64.7.96.3 Action hash(insert/${domain_name}-last_dial/${called_party_call_group}/${uuid})
306. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(api_hangup_hook=lua app.lua hangup)
307. Dialplan: sofia/external/7086872090@64.7.96.3 Action bridge(user/${destination_number}@${domain_name})
308. Dialplan: sofia/external/7086872090@64.7.96.3 Action lua(app.lua failure_handler)
309. Dialplan: sofia/external/7086872090@64.7.96.3 Action sleep(1000)
310. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(voicemail_action=save)
311. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(voicemail_id=${dialed_extension})
312. Dialplan: sofia/external/7086872090@64.7.96.3 Action set(voicemail_profile=default)
313. Dialplan: sofia/external/7086872090@64.7.96.3 Action lua(app.lua voicemail)
314. 2016-05-11 03:05:04.600915 [DEBUG] switch_core_state_machine.c:216 (sofia/external/7086872090@64.7.96.3) State Change CS_ROUTING -> CS_EXECUTE
315. 2016-05-11 03:05:04.600915 [DEBUG] switch_core_state_machine.c:532 (sofia/external/7086872090@64.7.96.3) State ROUTING going to sleep
316. 2016-05-11 03:05:04.600915 [DEBUG] switch_core_state_machine.c:473 (sofia/external/7086872090@64.7.96.3) Running State Change CS_EXECUTE
317. 2016-05-11 03:05:04.600915 [DEBUG] switch_core_state_machine.c:539 (sofia/external/7086872090@64.7.96.3) State EXECUTE
318. 2016-05-11 03:05:04.600915 [DEBUG] mod_sofia.c:196 sofia/external/7086872090@64.7.96.3 SOFIA EXECUTE
319. 2016-05-11 03:05:04.600915 [DEBUG] switch_core_state_machine.c:258 sofia/external/7086872090@64.7.96.3 Standard EXECUTE
320. EXECUTE sofia/external/7086872090@64.7.96.3 set(extension_uuid=9c50b3e8-714f-4dcf-8c35-13f42500338c)
321. 2016-05-11 03:05:04.622479 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [extension_uuid]=[9c50b3e8-714f-4dcf-8c35-13f42500338c]
322. EXECUTE sofia/external/7086872090@64.7.96.3 set(hold_music=)
323. 2016-05-11 03:05:04.622479 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [hold_music]=[UNDEF]
324. EXECUTE sofia/external/7086872090@64.7.96.3 set(forward_all_enabled=)
325. 2016-05-11 03:05:04.622479 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [forward_all_enabled]=[UNDEF]
326. EXECUTE sofia/external/7086872090@64.7.96.3 set(forward_all_destination=)
327. 2016-05-11 03:05:04.622479 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [forward_all_destination]=[UNDEF]
328. EXECUTE sofia/external/7086872090@64.7.96.3 set(forward_busy_enabled=)
329. 2016-05-11 03:05:04.622479 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [forward_busy_enabled]=[UNDEF]
330. EXECUTE sofia/external/7086872090@64.7.96.3 set(forward_busy_destination=)
331. 2016-05-11 03:05:04.622479 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [forward_busy_destination]=[UNDEF]
332. EXECUTE sofia/external/7086872090@64.7.96.3 set(forward_no_answer_enabled=)
333. 2016-05-11 03:05:04.660920 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [forward_no_answer_enabled]=[UNDEF]
334. EXECUTE sofia/external/7086872090@64.7.96.3 set(forward_no_answer_destination=)
335. 2016-05-11 03:05:04.660920 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [forward_no_answer_destination]=[UNDEF]
336. EXECUTE sofia/external/7086872090@64.7.96.3 set(forward_user_not_registered_enabled=)
337. 2016-05-11 03:05:04.660920 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [forward_user_not_registered_enabled]=[UNDEF]
338. EXECUTE sofia/external/7086872090@64.7.96.3 set(forward_user_not_registered_destination=)
339. 2016-05-11 03:05:04.680920 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [forward_user_not_registered_destination]=[UNDEF]
340. EXECUTE sofia/external/7086872090@64.7.96.3 set(do_not_disturb=)
341. 2016-05-11 03:05:04.680920 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [do_not_disturb]=[UNDEF]
342. EXECUTE sofia/external/7086872090@64.7.96.3 set(call_timeout=30)
343. 2016-05-11 03:05:04.680920 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [call_timeout]=[30]
344. EXECUTE sofia/external/7086872090@64.7.96.3 set(missed_call_app=)
345. 2016-05-11 03:05:04.680920 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [missed_call_app]=[UNDEF]
346. EXECUTE sofia/external/7086872090@64.7.96.3 set(missed_call_data=)
347. 2016-05-11 03:05:04.700921 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [missed_call_data]=[UNDEF]
348. EXECUTE sofia/external/7086872090@64.7.96.3 export(origination_callee_id_name=1001)
349. 2016-05-11 03:05:04.700921 [DEBUG] switch_channel.c:1293 EXPORT (export_vars) [origination_callee_id_name]=[1001]
350. EXECUTE sofia/external/7086872090@64.7.96.3 set(RFC2822_DATE=Wed, 11 May 2016 03:05:04 -0500)
351. 2016-05-11 03:05:04.700921 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [RFC2822_DATE]=[Wed, 11 May 2016 03:05:04 -0500]
352. EXECUTE sofia/external/7086872090@64.7.96.3 hash(insert/besindustries.urbancom.net-last_dial/7086872090/1001)
353. EXECUTE sofia/external/7086872090@64.7.96.3 eval(not_secure)
354. EXECUTE sofia/external/7086872090@64.7.96.3 limit(hash besindustries.urbancom.net 1001  )
355. 2016-05-11 03:05:04.700921 [DEBUG] switch_limit.c:126 incr called: besindustries.urbancom.net_1001 max:-1, interval:0
356. 2016-05-11 03:05:04.700921 [DEBUG] mod_hash.c:194 Usage for besindustries.urbancom.net_1001 is now 1
357. EXECUTE sofia/external/7086872090@64.7.96.3 bind_digit_action(local,*1,exec:execute_extension,dx XML besindustries.urbancom.net,both)
358. 2016-05-11 03:05:04.700921 [INFO] switch_ivr_async.c:214 Digit parser DPTOOLS: Setting realm to 'local'
359. 2016-05-11 03:05:04.700921 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *1/local/0 callback: 0x7fb2d5279400 data: 0x7fb250031b48
360. 2016-05-11 03:05:04.700921 [INFO] switch_ivr_async.c:214 Digit parser DPTOOLS: Setting realm to 'local'
361. 2016-05-11 03:05:04.700921 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *1/local/0 callback: 0x7fb2d5279400 data: 0x7fb250031bc8
362. EXECUTE sofia/external/7086872090@64.7.96.3 bind_digit_action(local,*2,exec:record_session,/var/lib/freeswitch/recordings/besindustries.urbancom.net/archive/2016/May/11/11828066-174f-11e6-b94d-8dcc9e1d3d65.wav,both)
363. 2016-05-11 03:05:04.700921 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *2/local/0 callback: 0x7fb2d5279400 data: 0x7fb250031e38
364. 2016-05-11 03:05:04.700921 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *2/local/0 callback: 0x7fb2d5279400 data: 0x7fb250031f08
365. EXECUTE sofia/external/7086872090@64.7.96.3 bind_digit_action(local,*3,exec:execute_extension,cf XML besindustries.urbancom.net,both)
366. 2016-05-11 03:05:04.700921 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *3/local/0 callback: 0x7fb2d5279400 data: 0x7fb2500320c8
367. 2016-05-11 03:05:04.700921 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *3/local/0 callback: 0x7fb2d5279400 data: 0x7fb250032148
368. EXECUTE sofia/external/7086872090@64.7.96.3 bind_digit_action(local,*4,exec:execute_extension,att_xfer XML besindustries.urbancom.net,both)
369. 2016-05-11 03:05:04.700921 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *4/local/0 callback: 0x7fb2d5279400 data: 0x7fb2500322c8
370. 2016-05-11 03:05:04.700921 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *4/local/0 callback: 0x7fb2d5279400 data: 0x7fb250032348
371. EXECUTE sofia/external/7086872090@64.7.96.3 digit_action_set_realm(local)
372. 2016-05-11 03:05:04.700921 [INFO] switch_ivr_async.c:214 Digit parser DPTOOLS: Setting realm to 'local'
373. EXECUTE sofia/external/7086872090@64.7.96.3 set(hangup_after_bridge=true)
374. 2016-05-11 03:05:04.700921 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [hangup_after_bridge]=[true]
375. EXECUTE sofia/external/7086872090@64.7.96.3 set(continue_on_fail=true)
376. 2016-05-11 03:05:04.700921 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [continue_on_fail]=[true]
377. EXECUTE sofia/external/7086872090@64.7.96.3 hash(insert/besindustries.urbancom.net-call_return/1001/7086872090)
378. EXECUTE sofia/external/7086872090@64.7.96.3 hash(insert/besindustries.urbancom.net-last_dial_ext/1001/11828066-174f-11e6-b94d-8dcc9e1d3d65)
379. EXECUTE sofia/external/7086872090@64.7.96.3 set(called_party_call_group=)
380. 2016-05-11 03:05:04.700921 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [called_party_call_group]=[UNDEF]
381. EXECUTE sofia/external/7086872090@64.7.96.3 hash(insert/besindustries.urbancom.net-last_dial//11828066-174f-11e6-b94d-8dcc9e1d3d65)
382. EXECUTE sofia/external/7086872090@64.7.96.3 set(api_hangup_hook=lua app.lua hangup)
383. 2016-05-11 03:05:04.700921 [DEBUG] mod_dptools.c:1498 SET sofia/external/7086872090@64.7.96.3 [api_hangup_hook]=[lua app.lua hangup]
384. EXECUTE sofia/external/7086872090@64.7.96.3 bridge(user/1001@besindustries.urbancom.net)
385. 2016-05-11 03:05:04.700921 [DEBUG] switch_channel.c:1247 sofia/external/7086872090@64.7.96.3 EXPORTING[export_vars] [dialed_extension]=[1001] to event
386. 2016-05-11 03:05:04.700921 [DEBUG] switch_channel.c:1247 sofia/external/7086872090@64.7.96.3 EXPORTING[export_vars] [origination_callee_id_name]=[1001] to event
387. 2016-05-11 03:05:04.700921 [DEBUG] switch_ivr_originate.c:2128 Parsing global variables
388. 2016-05-11 03:05:04.720903 [DEBUG] switch_channel.c:1247 sofia/external/7086872090@64.7.96.3 EXPORTING[export_vars] [dialed_extension]=[1001] to event
389. 2016-05-11 03:05:04.720903 [DEBUG] switch_channel.c:1247 sofia/external/7086872090@64.7.96.3 EXPORTING[export_vars] [origination_callee_id_name]=[1001] to event
390. 2016-05-11 03:05:04.720903 [DEBUG] switch_ivr_originate.c:2128 Parsing global variables
391. 2016-05-11 03:05:04.720903 [NOTICE] switch_channel.c:1101 New Channel sofia/internal/1001@73.72.98.76:5060 [11a47b6c-174f-11e6-b982-8dcc9e1d3d65]
392. 2016-05-11 03:05:04.720903 [DEBUG] mod_sofia.c:4776 (sofia/internal/1001@73.72.98.76:5060) State Change CS_NEW -> CS_INIT
393. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@73.72.98.76:5060) Running State Change CS_INIT
394. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/1001@73.72.98.76:5060) State INIT
395. 2016-05-11 03:05:04.720903 [DEBUG] mod_sofia.c:88 sofia/internal/1001@73.72.98.76:5060 SOFIA INIT
396. 2016-05-11 03:05:04.720903 [DEBUG] sofia_glue.c:1257 sofia/internal/1001@73.72.98.76:5060 sending invite version: 1.6.6  64bit
397. Local SDP:
398. v=0
399. o=FreeSWITCH 1462924644 1462924645 IN IP4 64.7.99.27
400. s=FreeSWITCH
401. c=IN IP4 64.7.99.27
402. t=0 0
403. m=audio 29260 RTP/AVP 0 101 13
404. a=rtpmap:0 PCMU/8000
405. a=rtpmap:101 telephone-event/8000
406. a=fmtp:101 0-16
407. a=rtpmap:13 CN/8000
408. a=ptime:20
409. a=sendrecv
410.  
411. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1001@73.72.98.76:5060 Standard INIT
412. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1001@73.72.98.76:5060) State Change CS_INIT -> CS_ROUTING
413. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/1001@73.72.98.76:5060) State INIT going to sleep
414. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@73.72.98.76:5060) Running State Change CS_ROUTING
415. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1001@73.72.98.76:5060) State ROUTING
416. 2016-05-11 03:05:04.720903 [DEBUG] mod_sofia.c:141 sofia/internal/1001@73.72.98.76:5060 SOFIA ROUTING
417. 2016-05-11 03:05:04.720903 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/1001@73.72.98.76:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
418. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1001@73.72.98.76:5060) State ROUTING going to sleep
419. send 1231 bytes to udp/[73.72.98.76]:5060 at 03:05:04.724623:
420.    ------------------------------------------------------------------------
421.    INVITE sip:1001@73.72.98.76:5060 SIP/2.0
422.    Via: SIP/2.0/UDP 64.7.99.27;rport;branch=z9hG4bKaUmBNmUZB1F0Q
423.    Max-Forwards: 67
424.    From: "Brent Sachnoff#Brent Sachnoff" <sip:7086872090@besindustries.urbancom.net>;tag=4g332eaZj4FyN
425.    To: <sip:1001@73.72.98.76:5060>
426.    Call-ID: e9030588-91f1-1234-b3a4-005056b9942b
427.    CSeq: 91140888 INVITE
428.    Contact: <sip:mod_sofia@64.7.99.27:5060>
429.    User-Agent: FreeSWITCH
430.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
431.    Supported: timer, path, replaces
432.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
433.    Content-Type: application/sdp
434.    Content-Disposition: session
435.    Content-Length: 240
436.    P-hint: mediaproxy applied
437.    X-FS-Support: update_display,send_info
438. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@73.72.98.76:5060) Running State Change CS_CONSUME_MEDIA
439.    Remote-Party-ID: "Brent Sachnoff#Brent Sachnoff" <sip:7086872090@besindustries.urbancom.net>;party=calling;screen=yes;privacy=off
440.    
441.    v=0
442.    o=FreeSWITCH 1462924644 1462924645 IN IP4 64.7.99.27
443.    s=FreeSWITCH
444.    c=IN IP4 64.7.99.27
445.    t=0 0
446.    m=audio 29260 RTP/AVP 0 101 13
447.    a=rtpmap:0 PCMU/8000
448.    a=rtpmap:101 telephone-event/8000
449.    a=fmtp:101 0-16
450.    a=rtpmap:13 CN/8000
451.    a=ptime:20
452.    ------------------------------------------------------------------------
453. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/1001@73.72.98.76:5060) State CONSUME_MEDIA
454. 2016-05-11 03:05:04.720903 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/1001@73.72.98.76:5060) State CONSUME_MEDIA going to sleep
455. 2016-05-11 03:05:04.720903 [DEBUG] sofia.c:6760 Channel sofia/internal/1001@73.72.98.76:5060 entering state [calling][0]
456. recv 394 bytes from udp/[73.72.98.76]:5060 at 03:05:04.748741:
457.    ------------------------------------------------------------------------
458.    SIP/2.0 100 Trying
459.    Call-ID: e9030588-91f1-1234-b3a4-005056b9942b
460.    CSeq: 91140888 INVITE
461.    Content-Length: 0
462.    From: "Brent Sachnoff#Brent Sachnoff" <sip:7086872090@besindustries.urbancom.net>;tag=4g332eaZj4FyN
463.    To: <sip:1001@73.72.98.76:5060>;tag=SP1935f3a4edaa5781a
464.    Via: SIP/2.0/UDP 10.20.12.27;branch=z9hG4bKaUmBNmUZB1F0Q;received=10.20.12.27;rport=5060
465.    Server: OBIHAI/OBi1062-5.0.0.3223
466.    
467.    ------------------------------------------------------------------------
468. recv 575 bytes from udp/[73.72.98.76]:5060 at 03:05:05.027017:
469.    ------------------------------------------------------------------------
470.    SIP/2.0 180 Ringing
471.    Call-ID: e9030588-91f1-1234-b3a4-005056b9942b
472.    CSeq: 91140888 INVITE
473.    Content-Length: 0
474.    From: "Brent Sachnoff#Brent Sachnoff" <sip:7086872090@besindustries.urbancom.net>;tag=4g332eaZj4FyN
475.    To: <sip:1001@73.72.98.76:5060>;tag=SP1935f3a4edaa5781a
476.    Via: SIP/2.0/UDP 10.20.12.27;branch=z9hG4bKaUmBNmUZB1F0Q;received=10.20.12.27;rport=5060
477.    Server: OBIHAI/OBi1062-5.0.0.3223
478.    Contact: <sip:1001@73.72.98.76:5060>
479.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
480.    Allow-Events: hold,talk,dialog
481.    
482.    ------------------------------------------------------------------------
483. 2016-05-11 03:05:05.020998 [DEBUG] sofia.c:6760 Channel sofia/internal/1001@73.72.98.76:5060 entering state [proceeding][180]
484. 2016-05-11 03:05:05.020998 [NOTICE] sofia.c:6862 Ring-Ready sofia/internal/1001@73.72.98.76:5060!
485. 2016-05-11 03:05:05.020998 [DEBUG] switch_channel.c:3340 (sofia/internal/1001@73.72.98.76:5060) Callstate Change DOWN -> RINGING
486. 2016-05-11 03:05:05.040976 [INFO] switch_ivr_originate.c:1216 Sending early media
487. 2016-05-11 03:05:05.040976 [DEBUG] switch_core_media.c:6033 AUDIO RTP [sofia/external/7086872090@64.7.96.3] 10.20.12.27 port 27174 -> 64.7.96.3 port 44250 codec: 0 ms: 20
488. 2016-05-11 03:05:05.040976 [DEBUG] switch_rtp.c:3802 Starting timer [soft] 160 bytes per 20ms
489. 2016-05-11 03:05:05.040976 [DEBUG] switch_core_media.c:6332 sofia/external/7086872090@64.7.96.3 Set 2833 dtmf send payload to 101
490. 2016-05-11 03:05:05.040976 [DEBUG] switch_core_media.c:6339 sofia/external/7086872090@64.7.96.3 Set 2833 dtmf receive payload to 101
491. 2016-05-11 03:05:05.040976 [DEBUG] switch_core_media.c:6362 sofia/external/7086872090@64.7.96.3 Set rtp dtmf delay to 40
492. 2016-05-11 03:05:05.040976 [DEBUG] mod_sofia.c:2330 Ring SDP:
493. v=0
494. o=FreeSWITCH 1462926731 1462926732 IN IP4 64.7.99.27
495. s=FreeSWITCH
496. c=IN IP4 64.7.99.27
497. t=0 0
498. m=audio 27174 RTP/AVP 0 101
499. a=rtpmap:0 PCMU/8000
500. a=rtpmap:101 telephone-event/8000
501. a=fmtp:101 0-16
502. a=ptime:20
503. a=sendrecv
504.  
505. 2016-05-11 03:05:05.040976 [NOTICE] mod_sofia.c:2333 Pre-Answer sofia/external/7086872090@64.7.96.3!
506. 2016-05-11 03:05:05.040976 [DEBUG] switch_channel.c:3468 (sofia/external/7086872090@64.7.96.3) Callstate Change RINGING -> EARLY
507. 2016-05-11 03:05:05.040976 [DEBUG] switch_ivr_originate.c:1274 Raw Codec Activation Success L16@8000hz 1 channel 20ms
508. 2016-05-11 03:05:05.040976 [DEBUG] switch_core_codec.c:221 sofia/external/7086872090@64.7.96.3 Push codec L16:100
509. 2016-05-11 03:05:05.040976 [DEBUG] switch_ivr_originate.c:1343 Play Ringback Tone [%(2000,4000,440,480)]
510. send 1171 bytes to udp/[64.7.96.3]:5060 at 03:05:05.050024:
511.    ------------------------------------------------------------------------
512.    SIP/2.0 183 Session Progress
513.    Via: SIP/2.0/UDP 64.7.96.3;branch=z9hG4bKfe59.feb100c6.0
514.    Via: SIP/2.0/UDP 64.7.96.6:5060;branch=z9hG4bK194a11786434f
515.    Record-Route: <sip:64.7.96.3;lr=on;ftag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388;mp=yes;vsf=AAAAAAEACAB4AQYeDh55ABoYNy45Ni4z>
516.    From: "Brent Sachnoff" <sip:7086872090@64.7.96.3>;tag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388
517.    To: <sip:16303437370@64.7.96.3>;tag=pj7BjD4ZFQ1DQ
518.    Call-ID: ffe3d80-7321e7b0-bfc3-6600740@64.7.96.6
519.    CSeq: 101 INVITE
520.    Contact: <sip:16303437370@64.7.99.27:5080;transport=udp>
521.    User-Agent: FreeSWITCH
522.    Accept: application/sdp
523.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
524.    Supported: timer, path, replaces
525.    Allow-Events: talk, hold, conference, refer
526.    Content-Type: application/sdp
527.    Content-Disposition: session
528.    Content-Length: 216
529.    Remote-Party-ID: "6303437370" <sip:6303437370@64.7.96.3>;party=calling;privacy=off;screen=no
530.    
531.    v=0
532.    o=FreeSWITCH 1462926731 1462926732 IN IP4 64.7.99.27
533.    s=FreeSWITCH
534.    c=IN IP4 64.7.99.27
535.    t=0 0
536.    m=audio 27174 RTP/AVP 0 101
537.    a=rtpmap:0 PCMU/8000
538.    a=rtpmap:101 telephone-event/8000
539.    a=fmtp:101 0-16
540.    a=ptime:20
541.    ------------------------------------------------------------------------
542. 2016-05-11 03:05:05.060917 [DEBUG] sofia.c:6760 Channel sofia/external/7086872090@64.7.96.3 entering state [early][183]
543. 2016-05-11 03:05:05.100897 [DEBUG] switch_rtp.c:6654 Correct audio ip/port confirmed.
544. recv 955 bytes from udp/[73.72.98.76]:5060 at 03:05:06.945970:
545.    ------------------------------------------------------------------------
546.    SIP/2.0 200 OK
547.    Call-ID: e9030588-91f1-1234-b3a4-005056b9942b
548.    CSeq: 91140888 INVITE
549.    Content-Length: 229
550.    From: "Brent Sachnoff#Brent Sachnoff" <sip:7086872090@besindustries.urbancom.net>;tag=4g332eaZj4FyN
551.    To: <sip:1001@73.72.98.76:5060>;tag=SP1935f3a4edaa5781a
552.    Via: SIP/2.0/UDP 10.20.12.27;branch=z9hG4bKaUmBNmUZB1F0Q;received=10.20.12.27;rport=5060
553.    Server: OBIHAI/OBi1062-5.0.0.3223
554.    Contact: <sip:1001@73.72.98.76:5060>
555.    Supported: replaces, eventlist, record-aware
556.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
557.    Accept: application/vnd.etsi.aoc+xml,application/dtmf-relay,application/sdp
558.    Allow-Events: hold,talk,dialog
559.    Content-Type: application/sdp
560.    
561.    v=0
562.    o=- 12418691 1 IN IP4 73.72.98.76
563.    s=-
564.    c=IN IP4 73.72.98.76
565.    t=0 0
566.    m=audio 16606 RTP/AVP 0 101
567.    a=rtpmap:0 PCMU/8000
568.    a=rtpmap:101 telephone-event/8000
569.    a=fmtp:101 0-15
570.    a=sendrecv
571.    a=ptime:20
572.    a=xg726bitorder:big-endian
573.    ------------------------------------------------------------------------
574. 2016-05-11 03:05:06.940917 [DEBUG] sofia.c:6760 Channel sofia/internal/1001@73.72.98.76:5060 entering state [completing][200]
575. 2016-05-11 03:05:06.940917 [DEBUG] sofia.c:6770 Remote SDP:
576. v=0
577. o=- 12418691 1 IN IP4 73.72.98.76
578. s=-
579. c=IN IP4 73.72.98.76
580. t=0 0
581. m=audio 16606 RTP/AVP 0 101
582. a=rtpmap:0 PCMU/8000
583. a=rtpmap:101 telephone-event/8000
584. a=fmtp:101 0-15
585. a=ptime:20
586. a=xg726bitorder:big-endian
587.  
588. send 408 bytes to udp/[73.72.98.76]:5060 at 03:05:06.948349:
589.    ------------------------------------------------------------------------
590.    ACK sip:1001@73.72.98.76:5060 SIP/2.0
591.    Via: SIP/2.0/UDP 64.7.99.27;rport;branch=z9hG4bKB4D4pFc3895jK
592.    Max-Forwards: 70
593.    From: "Brent Sachnoff#Brent Sachnoff" <sip:7086872090@besindustries.urbancom.net>;tag=4g332eaZj4FyN
594.    To: <sip:1001@73.72.98.76:5060>;tag=SP1935f3a4edaa5781a
595.    Call-ID: e9030588-91f1-1234-b3a4-005056b9942b
596.    CSeq: 91140888 ACK
597.    Contact: <sip:mod_sofia@64.7.99.27:5060>
598.    Content-Length: 0
599.    
600.    ------------------------------------------------------------------------
601. 2016-05-11 03:05:06.940917 [DEBUG] sofia.c:6760 Channel sofia/internal/1001@73.72.98.76:5060 entering state [ready][200]
602. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_media.c:4161 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
603. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_media.c:4216 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
604. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_media.c:4077 Set telephone-event payload to 101@8000
605. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_media.c:2906 Set Codec sofia/internal/1001@73.72.98.76:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
606. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_codec.c:111 sofia/internal/1001@73.72.98.76:5060 Original read codec set to PCMU:0
607. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_media.c:4429 Set telephone-event payload to 101@8000
608. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_media.c:4485 sofia/internal/1001@73.72.98.76:5060 Set 2833 dtmf send payload to 101 recv payload to 101
609. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_media.c:6033 AUDIO RTP [sofia/internal/1001@73.72.98.76:5060] 10.20.12.27 port 29260 -> 73.72.98.76 port 16606 codec: 0 ms: 20
610. 2016-05-11 03:05:06.940917 [DEBUG] switch_rtp.c:3802 Starting timer [soft] 160 bytes per 20ms
611. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_media.c:6332 sofia/internal/1001@73.72.98.76:5060 Set 2833 dtmf send payload to 101
612. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_media.c:6339 sofia/internal/1001@73.72.98.76:5060 Set 2833 dtmf receive payload to 101
613. 2016-05-11 03:05:06.940917 [DEBUG] switch_core_media.c:6362 sofia/internal/1001@73.72.98.76:5060 Set rtp dtmf delay to 40
614. 2016-05-11 03:05:06.940917 [NOTICE] sofia.c:7724 Channel [sofia/internal/1001@73.72.98.76:5060] has been answered
615. 2016-05-11 03:05:06.940917 [DEBUG] switch_channel.c:3767 (sofia/internal/1001@73.72.98.76:5060) Callstate Change RINGING -> ACTIVE
616. 2016-05-11 03:05:06.960923 [DEBUG] switch_core_codec.c:246 sofia/external/7086872090@64.7.96.3 Restore previous codec PCMU:0.
617. 2016-05-11 03:05:06.960923 [DEBUG] mod_sofia.c:799 Local SDP sofia/external/7086872090@64.7.96.3:
618. v=0
619. o=FreeSWITCH 1462926731 1462926733 IN IP4 64.7.99.27
620. s=FreeSWITCH
621. c=IN IP4 64.7.99.27
622. t=0 0
623. m=audio 27174 RTP/AVP 0 101
624. a=rtpmap:0 PCMU/8000
625. a=rtpmap:101 telephone-event/8000
626. a=fmtp:101 0-16
627. a=ptime:20
628. a=sendrecv
629.  
630. send 1173 bytes to udp/[64.7.96.3]:5060 at 03:05:06.967610:
631.    ------------------------------------------------------------------------
632.    SIP/2.0 200 OK
633.    Via: SIP/2.0/UDP 64.7.96.3;branch=z9hG4bKfe59.feb100c6.0
634.    Via: SIP/2.0/UDP 64.7.96.6:5060;branch=z9hG4bK194a11786434f
635. 2016-05-11 03:05:06.960923 [NOTICE] switch_ivr_originate.c:3550 Channel [sofia/external/7086872090@64.7.96.3] has been answered
636.    Record-Route: <sip:64.7.96.3;lr=on;ftag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388;mp=yes;vsf=AAAAAAEACAB4AQYeDh55ABoYNy45Ni4z>
637.    From: "Brent Sachnoff" <sip:7086872090@64.7.96.3>;tag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388
638.    To: <sip:16303437370@64.7.96.3>;tag=pj7BjD4ZFQ1DQ
639.    Call-ID: ffe3d80-7321e7b0-bfc3-6600740@64.7.96.6
640.    CSeq: 101 INVITE
641.    Contact: <sip:16303437370@64.7.99.27:5080;transport=udp>
642.    User-Agent: FreeSWITCH
643.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
644.    Require: timer
645.    Supported: timer, path, replaces
646.    Allow-Events: talk, hold, conference, refer
647.    Session-Expires: 1800;refresher=uac
648.    Content-Type: application/sdp
649.    Content-Disposition: session
650.    Content-Length: 216
651.    Remote-Party-ID: "1001" <sip:1001@64.7.96.3>;party=calling;privacy=off;screen=no
652.    
653.    v=0
654.    o=FreeSWITCH 1462926731 1462926732 IN IP4 64.7.99.27
655.    s=FreeSWITCH
656.    c=IN IP4 64.7.99.27
657.    t=0 0
658.    m=audio 27174 RTP/AVP 0 101
659.    a=rtpmap:0 PCMU/8000
660.    a=rtpmap:101 telephone-event/8000
661.    a=fmtp:101 0-16
662.    a=ptime:20
663.    ------------------------------------------------------------------------
664. 2016-05-11 03:05:06.960923 [DEBUG] switch_channel.c:3767 (sofia/external/7086872090@64.7.96.3) Callstate Change EARLY -> ACTIVE
665. 2016-05-11 03:05:06.960923 [DEBUG] sofia.c:6760 Channel sofia/external/7086872090@64.7.96.3 entering state [completed][200]
666. 2016-05-11 03:05:06.960923 [DEBUG] switch_ivr_originate.c:3608 Originate Resulted in Success: [sofia/internal/1001@73.72.98.76:5060]
667. 2016-05-11 03:05:06.960923 [DEBUG] switch_ivr_originate.c:3608 Originate Resulted in Success: [sofia/internal/1001@73.72.98.76:5060]
668. 2016-05-11 03:05:06.960923 [DEBUG] switch_ivr_bridge.c:1591 (sofia/internal/1001@73.72.98.76:5060) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
669. 2016-05-11 03:05:06.960923 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@73.72.98.76:5060) Running State Change CS_EXCHANGE_MEDIA
670. 2016-05-11 03:05:06.960923 [DEBUG] switch_core_state_machine.c:542 (sofia/internal/1001@73.72.98.76:5060) State EXCHANGE_MEDIA
671. 2016-05-11 03:05:06.960923 [DEBUG] mod_sofia.c:613 SOFIA EXCHANGE_MEDIA
672. recv 610 bytes from udp/[64.7.96.3]:5060 at 03:05:06.985481:
673.    ------------------------------------------------------------------------
674.    ACK sip:16303437370@64.7.99.27:5080;transport=udp SIP/2.0
675.    Record-Route: <sip:64.7.96.3;lr=on;ftag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388>
676.    Via: SIP/2.0/UDP 64.7.96.3;branch=z9hG4bKfe59.feb100c6.2
677.    Via: SIP/2.0/UDP 64.7.96.6:5060;branch=z9hG4bK194a25d5cacb9
678.    From: "Brent Sachnoff" <sip:7086872090@64.7.96.3>;tag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388
679.    To: <sip:16303437370@64.7.96.3>;tag=pj7BjD4ZFQ1DQ
680.    Date: Wed, 11 May 2016 08:05:04 GMT
681.    Call-ID: ffe3d80-7321e7b0-bfc3-6600740@64.7.96.6
682.    Max-Forwards: 69
683.    CSeq: 101 ACK
684.    Allow-Events: presence, kpml
685.    Content-Length: 0
686.    P-hint: rr-enforced
687.    
688.    ------------------------------------------------------------------------
689. 2016-05-11 03:05:06.980903 [DEBUG] sofia.c:6760 Channel sofia/external/7086872090@64.7.96.3 entering state [ready][200]
690. 2016-05-11 03:05:07.020906 [DEBUG] switch_rtp.c:6654 Correct audio ip/port confirmed.
691. 2016-05-11 03:05:07.440904 [DEBUG] switch_rtp.c:6654 Correct audio ip/port confirmed.
692. recv 479 bytes from udp/[73.72.98.76]:5060 at 03:05:08.180976:
693.    ------------------------------------------------------------------------
694.    BYE sip:mod_sofia@10.20.12.27:5060 SIP/2.0
695.    Call-ID: e9030588-91f1-1234-b3a4-005056b9942b
696.    Content-Length: 0
697.    CSeq: 8001 BYE
698.    From: <sip:1001@172.20.21.151>;tag=SP1935f3a4edaa5781a
699.    Max-Forwards: 70
700.    To: "Brent Sachnoff#Brent Sachnoff" <sip:7086872090@besindustries.urbancom.net>;tag=4g332eaZj4FyN
701.    Via: SIP/2.0/UDP 73.72.98.76:5060;branch=z9hG4bK-f3fda812;rport
702.    User-Agent: OBIHAI/OBi1062-5.0.0.3223
703.    X-RTP-Stat: PS=35,OS=6020,PR=56,OR=9632,PL=0,JI=0,DU=0,EN=G711U,DE=G711U
704.    
705.    ------------------------------------------------------------------------
706. 2016-05-11 03:05:08.180958 [NOTICE] sofia.c:952 Hangup sofia/internal/1001@73.72.98.76:5060 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
707. 2016-05-11 03:05:08.180958 [DEBUG] switch_ivr_bridge.c:699 sofia/internal/1001@73.72.98.76:5060 ending bridge by request from write function
708. send 493 bytes to udp/[73.72.98.76]:5060 at 03:05:08.187954:
709.    ------------------------------------------------------------------------
710.    SIP/2.0 200 OK
711.    Via: SIP/2.0/UDP 73.72.98.76:5060;branch=z9hG4bK-f3fda812;rport=5060
712.    From: <sip:1001@172.20.21.151>;tag=SP1935f3a4edaa5781a
713.    To: "Brent Sachnoff#Brent Sachnoff" <sip:7086872090@besindustries.urbancom.net>;tag=4g332eaZj4FyN
714.    Call-ID: e9030588-91f1-1234-b3a4-005056b9942b
715.    CSeq: 8001 BYE
716.    User-Agent: FreeSWITCH
717.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
718.    Supported: timer, path, replaces
719.    Content-Length: 0
720.    
721.    ------------------------------------------------------------------------
722. 2016-05-11 03:05:08.180958 [DEBUG] switch_ivr_bridge.c:778 BRIDGE THREAD DONE [sofia/external/7086872090@64.7.96.3]
723. 2016-05-11 03:05:08.180958 [DEBUG] switch_ivr_bridge.c:1689 sofia/internal/1001@73.72.98.76:5060 skip receive message [UNBRIDGE] (channel is hungup already)
724. 2016-05-11 03:05:08.180958 [NOTICE] switch_ivr_bridge.c:1741 Hangup sofia/external/7086872090@64.7.96.3 [CS_EXECUTE] [NORMAL_CLEARING]
725. 2016-05-11 03:05:08.180958 [DEBUG] mod_hash.c:297 Usage for besindustries.urbancom.net_1001 is now 0
726. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_session.c:2796 sofia/external/7086872090@64.7.96.3 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
727. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:539 (sofia/external/7086872090@64.7.96.3) State EXECUTE going to sleep
728. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:473 (sofia/external/7086872090@64.7.96.3) Running State Change CS_HANGUP
729. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:739 (sofia/external/7086872090@64.7.96.3) Callstate Change ACTIVE -> HANGUP
730. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:741 (sofia/external/7086872090@64.7.96.3) State HANGUP
731. 2016-05-11 03:05:08.180958 [DEBUG] mod_sofia.c:425 sofia/external/7086872090@64.7.96.3 Overriding SIP cause 480 with 200 from the other leg
732. 2016-05-11 03:05:08.180958 [DEBUG] mod_sofia.c:431 Channel sofia/external/7086872090@64.7.96.3 hanging up, cause: NORMAL_CLEARING
733. 2016-05-11 03:05:08.180958 [DEBUG] mod_sofia.c:484 Sending BYE to sofia/external/7086872090@64.7.96.3
734. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:60 sofia/external/7086872090@64.7.96.3 Standard HANGUP, cause: NORMAL_CLEARING
735. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:741 (sofia/external/7086872090@64.7.96.3) State HANGUP going to sleep
736. 2016-05-11 03:05:08.180958 [DEBUG] switch_ivr_bridge.c:705 sofia/internal/1001@73.72.98.76:5060 ending bridge by request from read function
737. 2016-05-11 03:05:08.180958 [DEBUG] switch_ivr_bridge.c:778 BRIDGE THREAD DONE [sofia/internal/1001@73.72.98.76:5060]
738. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:542 (sofia/internal/1001@73.72.98.76:5060) State EXCHANGE_MEDIA going to sleep
739. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@73.72.98.76:5060) Running State Change CS_HANGUP
740. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/1001@73.72.98.76:5060) Callstate Change ACTIVE -> HANGUP
741. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1001@73.72.98.76:5060) State HANGUP
742. 2016-05-11 03:05:08.180958 [DEBUG] mod_sofia.c:431 Channel sofia/internal/1001@73.72.98.76:5060 hanging up, cause: NORMAL_CLEARING
743. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1001@73.72.98.76:5060 Standard HANGUP, cause: NORMAL_CLEARING
744. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1001@73.72.98.76:5060) State HANGUP going to sleep
745. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/1001@73.72.98.76:5060) State Change CS_HANGUP -> CS_REPORTING
746. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@73.72.98.76:5060) Running State Change CS_REPORTING
747. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1001@73.72.98.76:5060) State REPORTING
748. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1001@73.72.98.76:5060 Standard REPORTING, cause: NORMAL_CLEARING
749. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1001@73.72.98.76:5060) State REPORTING going to sleep
750. send 760 bytes to udp/[64.7.96.3]:5060 at 03:05:08.190856:
751.    ------------------------------------------------------------------------
752.    BYE sip:6006@64.7.96.6:5060 SIP/2.0
753.    Via: SIP/2.0/UDP 64.7.99.27:5080;rport;branch=z9hG4bKp4X0yeSQQ1KDH
754.    Route: <sip:64.7.96.3;lr=on;ftag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388;mp=yes;vsf=AAAAAAEACAB4AQYeDh55ABoYNy45Ni4z>
755.    Max-Forwards: 70
756.    From: <sip:16303437370@64.7.96.3>;tag=pj7BjD4ZFQ1DQ
757.    To: "Brent Sachnoff" <sip:7086872090@64.7.96.3>;tag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388
758.    Call-ID: ffe3d80-7321e7b0-bfc3-6600740@64.7.96.6
759.    CSeq: 91140890 BYE
760.    User-Agent: FreeSWITCH
761.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
762.    Supported: timer, path, replaces
763.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
764.    Content-Length: 0
765.    X-RTP-Stat: PS=35,OS=6020,PR=56,OR=9632,PL=0,JI=0,DU=0,EN=G711U,DE=G711U
766.    
767.    ------------------------------------------------------------------------
768. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/1001@73.72.98.76:5060) State Change CS_REPORTING -> CS_DESTROY
769. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_session.c:1646 Session 26 (sofia/internal/1001@73.72.98.76:5060) Locked, Waiting on external entities
770. 2016-05-11 03:05:08.180958 [NOTICE] switch_core_session.c:1664 Session 26 (sofia/internal/1001@73.72.98.76:5060) Ended
771. 2016-05-11 03:05:08.180958 [NOTICE] switch_core_session.c:1668 Close Channel sofia/internal/1001@73.72.98.76:5060 [CS_DESTROY]
772. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/1001@73.72.98.76:5060) Running State Change CS_DESTROY
773. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1001@73.72.98.76:5060) State DESTROY
774. 2016-05-11 03:05:08.180958 [DEBUG] mod_sofia.c:341 sofia/internal/1001@73.72.98.76:5060 SOFIA DESTROY
775. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1001@73.72.98.76:5060 Standard DESTROY
776. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1001@73.72.98.76:5060) State DESTROY going to sleep
777. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:672 Hangup Command with no Session lua(app.lua hangup):
778.  
779. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:508 (sofia/external/7086872090@64.7.96.3) State Change CS_HANGUP -> CS_REPORTING
780. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:473 (sofia/external/7086872090@64.7.96.3) Running State Change CS_REPORTING
781. 2016-05-11 03:05:08.180958 [DEBUG] switch_core_state_machine.c:827 (sofia/external/7086872090@64.7.96.3) State REPORTING
782. recv 369 bytes from udp/[64.7.96.3]:5060 at 03:05:08.204640:
783.    ------------------------------------------------------------------------
784.    SIP/2.0 200 OK
785.    Via: SIP/2.0/UDP 64.7.99.27:5080;rport=5080;branch=z9hG4bKp4X0yeSQQ1KDH
786.    From: <sip:16303437370@64.7.96.3>;tag=pj7BjD4ZFQ1DQ
787.    To: "Brent Sachnoff" <sip:7086872090@64.7.96.3>;tag=eea75a70-f420-4416-8968-d6e5dfadb3f4-30174388
788.    Date: Wed, 11 May 2016 08:05:08 GMT
789.    Call-ID: ffe3d80-7321e7b0-bfc3-6600740@64.7.96.6
790.    CSeq: 91140890 BYE
791.    Content-Length: 0
792.    
793.    ------------------------------------------------------------------------
794. 2016-05-11 03:05:08.260888 [DEBUG] switch_core_state_machine.c:104 sofia/external/7086872090@64.7.96.3 Standard REPORTING, cause: NORMAL_CLEARING
795. 2016-05-11 03:05:08.260888 [DEBUG] switch_core_state_machine.c:827 (sofia/external/7086872090@64.7.96.3) State REPORTING going to sleep
796. 2016-05-11 03:05:08.260888 [DEBUG] switch_core_state_machine.c:499 (sofia/external/7086872090@64.7.96.3) State Change CS_REPORTING -> CS_DESTROY
797. 2016-05-11 03:05:08.260888 [DEBUG] switch_core_session.c:1646 Session 25 (sofia/external/7086872090@64.7.96.3) Locked, Waiting on external entities
798. 2016-05-11 03:05:08.260888 [NOTICE] switch_core_session.c:1664 Session 25 (sofia/external/7086872090@64.7.96.3) Ended
799. 2016-05-11 03:05:08.260888 [NOTICE] switch_core_session.c:1668 Close Channel sofia/external/7086872090@64.7.96.3 [CS_DESTROY]
800. 2016-05-11 03:05:08.260888 [DEBUG] switch_core_state_machine.c:630 (sofia/external/7086872090@64.7.96.3) Running State Change CS_DESTROY
801. 2016-05-11 03:05:08.260888 [DEBUG] switch_core_state_machine.c:640 (sofia/external/7086872090@64.7.96.3) State DESTROY
802. 2016-05-11 03:05:08.260888 [DEBUG] mod_sofia.c:341 sofia/external/7086872090@64.7.96.3 SOFIA DESTROY
803. 2016-05-11 03:05:08.260888 [DEBUG] switch_core_state_machine.c:111 sofia/external/7086872090@64.7.96.3 Standard DESTROY
804. 2016-05-11 03:05:08.260888 [DEBUG] switch_core_state_machine.c:640 (sofia/external/7086872090@64.7.96.3) State DESTROY going to sleep
805. recv 850 bytes from udp/[73.72.98.76]:5060 at 03:05:17.622365:
806.    ------------------------------------------------------------------------
807.    REGISTER sip:besindustries.urbancom.net:5060 SIP/2.0
808.    Call-ID: 606bcf41@172.20.21.151
809.    Content-Length: 0
810.    CSeq: 16653 REGISTER
811.    From: <sip:1001@besindustries.urbancom.net>;tag=SP1f75f1c86bedf8eae
812.    Max-Forwards: 70
813.    To: <sip:1001@besindustries.urbancom.net>
814.    Via: SIP/2.0/UDP 73.72.98.76:5060;branch=z9hG4bK-eff76ad7;rport
815.    Authorization: Digest algorithm=MD5,nc=00000053,qop=auth,cnonce="5f3f9cfc",nonce="5d11441e-1749-11e6-b890-8dcc9e1d3d65",realm="besindustries.urbancom.net",response="dfcca36625722d7f5428a36c8c77d4fd",uri="sip:besindustries.urbancom.net:5060",username="1001"
816.    User-Agent: OBIHAI/OBi1062-5.0.0.3223
817.    Contact: <sip:1001@73.72.98.76:5060>;expires=60;+sip.instance="<urn:uuid:00000000-0000-0000-0000-9cadef700ee0>"
818.   Allow: ACK,BYE,CANCEL,INFO,INVITE,NOTIFY,OPTIONS,PRACK,REFER,UPDATE
819.    Supported: replaces, eventlist, record-aware
820.    
821.    ------------------------------------------------------------------------
822. send 546 bytes to udp/[73.72.98.76]:5060 at 03:05:17.636531:
823.    ------------------------------------------------------------------------
824.    SIP/2.0 200 OK
825.    Via: SIP/2.0/UDP 73.72.98.76:5060;branch=z9hG4bK-eff76ad7;rport=5060
826.    From: <sip:1001@besindustries.urbancom.net>;tag=SP1f75f1c86bedf8eae
827.    To: <sip:1001@besindustries.urbancom.net>;tag=5Svv49t2FD6gH
828.    Call-ID: 606bcf41@172.20.21.151
829.    CSeq: 16653 REGISTER
830.    Contact: <sip:1001@73.72.98.76:5060>;expires=60
831.    Date: Wed, 11 May 2016 08:05:17 GMT
832.    User-Agent: FreeSWITCH
833.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
834.    Supported: timer, path, replaces
835.    Content-Length: 0
836.    
837.    ------------------------------------------------------------------------
838. recv 850 bytes from udp/[73.72.98.76]:5060 at 03:05:47.650952:
839.    ------------------------------------------------------------------------
840.    REGISTER sip:besindustries.urbancom.net:5060 SIP/2.0
841.    Call-ID: 606bcf41@172.20.21.151
842.    Content-Length: 0
843.    CSeq: 16654 REGISTER
844.    From: <sip:1001@besindustries.urbancom.net>;tag=SP1f75f1c86bedf8eae
845.    Max-Forwards: 70
846.    To: <sip:1001@besindustries.urbancom.net>
847.    Via: SIP/2.0/UDP 73.72.98.76:5060;branch=z9hG4bK-67d716eb;rport
848.    Authorization: Digest algorithm=MD5,nc=00000054,qop=auth,cnonce="5f3f9cfc",nonce="5d11441e-1749-11e6-b890-8dcc9e1d3d65",realm="besindustries.urbancom.net",response="1cab14d805c3cd8691c80851cccc7622",uri="sip:besindustries.urbancom.net:5060",username="1001"
849.    User-Agent: OBIHAI/OBi1062-5.0.0.3223
850.    Contact: <sip:1001@73.72.98.76:5060>;expires=60;+sip.instance="<urn:uuid:00000000-0000-0000-0000-9cadef700ee0>"
851.   Allow: ACK,BYE,CANCEL,INFO,INVITE,NOTIFY,OPTIONS,PRACK,REFER,UPDATE
852.    Supported: replaces, eventlist, record-aware
853.    
854.    ------------------------------------------------------------------------
855. send 546 bytes to udp/[73.72.98.76]:5060 at 03:05:47.666108:
856.    ------------------------------------------------------------------------
857.    SIP/2.0 200 OK
858.    Via: SIP/2.0/UDP 73.72.98.76:5060;branch=z9hG4bK-67d716eb;rport=5060
859.    From: <sip:1001@besindustries.urbancom.net>;tag=SP1f75f1c86bedf8eae
860.    To: <sip:1001@besindustries.urbancom.net>;tag=62NN64B6cpv3c
861.    Call-ID: 606bcf41@172.20.21.151
862.    CSeq: 16654 REGISTER
863.    Contact: <sip:1001@73.72.98.76:5060>;expires=60
864.    Date: Wed, 11 May 2016 08:05:47 GMT
865.    User-Agent: FreeSWITCH
866.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
867.    Supported: timer, path, replaces
868.    Content-Length: 0
869.    
870.    ------------------------------------------------------------------------
871. freeswitch@internal>