1. recv 1280 bytes from udp/[172.19.51.21]:5060 at 23:52:59.065331:
2.    ------------------------------------------------------------------------
3.    INVITE sip:0108008080800@pbx.[anonym].net;user=phone SIP/2.0
4.    Via: SIP/2.0/UDP 172.19.51.21:5060;branch=z9hG4bK-B89D2271;rport
5.    From: <sip:11@pbx.[anonym].net>;tag=4241842629
6.    To: <sip:0108008080800@pbx.[anonym].net;user=phone>
7.    Call-ID: fa59464a61e75b01907f0090332616fc@5
8.    CSeq: 1286550375 INVITE
9.    Contact: <sip:11@172.19.51.21:5060;transport=UDP>
10.   Allow: REGISTER,SUBSCRIBE,NOTIFY,INVITE,ACK,PRACK,OPTIONS,BYE,CANCEL,REFER,INFO,UPDATE,PUBLISH
11.    Content-Length: 514
12.    Content-Type: application/sdp
13.    Max-Forwards: 63
14.    Supported: 100rel,replaces,privacy,timer,from-change,histinfo,answermode
15.    User-Agent: (innovaphone IP240/12r1 sr26 [12.1257/121257/301])
16.    P-Preferred-Identity: <sip:11@pbx.[anonym].net;user=phone>
17.    Recv-Info: dtmf
18.    P-Sig-Options: Sending-Complete,bc=038090a3
19.  
20.    v=0
21.    o=- 5 1 IN IP4 172.19.51.21
22.    s=-
23.    t=0 0
24.    m=audio 16386 RTP/AVP 8 18 4 0 101 13
25.    c=IN IP4 172.19.51.21
26.    a=rtpmap:8 PCMA/8000
27.    a=rtpmap:18 G729/8000
28.    a=rtpmap:4 G723/8000
29.    a=rtpmap:0 PCMU/8000
30.    a=rtpmap:101 telephone-event/8000
31.    a=rtpmap:13 CN/8000
32.    a=fmtp:18 annexb=yes
33.    a=fmtp:101 0-15
34.    a=ptime:20
35.    a=silenceSupp:on - - - -
36.    a=sendrecv
37.    a=ice-ufrag:w7Ce
38.    a=ice-pwd:VWGNhMKhGBOF4qSOrfWHP7
39.    a=candidate:1 1 UDP 2130569471 172.19.51.21 16386 typ host
40.    a=candidate:1 2 UDP 2130569726 172.19.51.21 16387 typ host
41.    ------------------------------------------------------------------------
42. 2018-11-10 23:52:59.055672 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/11@pbx.[anonym].net [4ef5163f-777a-413d-8ba7-5a983d75f668]
43. 2018-11-10 23:52:59.055672 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@pbx.[anonym].net) Running State Change CS_NEW (Cur 1 Tot 1)
44. 2018-11-10 23:52:59.055672 [DEBUG] sofia.c:10080 sofia/internal/11@pbx.[anonym].net receiving invite from 172.19.51.21:5060 version: 1.8.2 -3-a98a958ac3 64bit
45. 2018-11-10 23:52:59.055672 [DEBUG] sofia.c:10251 IP 172.19.51.21 Rejected by acl "domains". Falling back to Digest auth.
46. 2018-11-10 23:52:59.055672 [WARNING] sofia_reg.c:1793 SIP auth challenge (INVITE) on sofia profile 'internal' for [0108008080800@pbx.[anonym].net] from ip 172.19.51.21
47. 2018-11-10 23:52:59.055672 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/11@pbx.[anonym].net) State NEW
48. send 805 bytes to udp/[172.19.51.21]:5060 at 23:52:59.071069:
49.    ------------------------------------------------------------------------
50.    SIP/2.0 407 Proxy Authentication Required
51.    Via: SIP/2.0/UDP 172.19.51.21:5060;branch=z9hG4bK-B89D2271;rport=5060
52.    From: <sip:11@pbx.[anonym].net>;tag=4241842629
53.    To: <sip:0108008080800@pbx.[anonym].net;user=phone>;tag=BQK6yKFpygX2Q
54.    Call-ID: fa59464a61e75b01907f0090332616fc@5
55.    CSeq: 1286550375 INVITE
56.    User-Agent: FreeSWITCH
57.    Accept: application/sdp
58.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
59.    Supported: timer, path, replaces
60.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
61.    Proxy-Authenticate: Digest realm="pbx.[anonym].net", nonce="63e024d3-63ce-40e6-96e4-609a5ba18097", algorithm=MD5, qop="auth"
62.    Content-Length: 0
63.  
64.    ------------------------------------------------------------------------
65. 2018-11-10 23:52:59.055672 [DEBUG] sofia.c:2413 detaching session 4ef5163f-777a-413d-8ba7-5a983d75f668
66. recv 392 bytes from udp/[172.19.51.21]:5060 at 23:52:59.073914:
67.    ------------------------------------------------------------------------
68.    ACK sip:0108008080800@pbx.[anonym].net;user=phone SIP/2.0
69.    Via: SIP/2.0/UDP 172.19.51.21:5060;branch=z9hG4bK-B89D2271;rport
70.    From: <sip:11@pbx.[anonym].net>;tag=4241842629
71.    To: <sip:0108008080800@pbx.[anonym].net;user=phone>;tag=BQK6yKFpygX2Q
72.    Call-ID: fa59464a61e75b01907f0090332616fc@5
73.    CSeq: 1286550375 ACK
74.    Contact: <sip:11@172.19.51.21:5060;transport=UDP>
75.    Content-Length: 0
76.    Max-Forwards: 70
77.  
78.    ------------------------------------------------------------------------
79. recv 1544 bytes from udp/[172.19.51.21]:5060 at 23:52:59.077003:
80.    ------------------------------------------------------------------------
81.    INVITE sip:0108008080800@pbx.[anonym].net;user=phone SIP/2.0
82.    Proxy-Authorization: Digest username="11",realm="pbx.[anonym].net",nonce="63e024d3-63ce-40e6-96e4-609a5ba18097",response="f933176b57b576d0b597e4b3c45fcc20",uri="sip:0108008080800@pbx.[anonym].net;user=phone",qop=auth,cnonce="00039f9680560c34",nc=00000001,algorithm=MD5
83.    Via: SIP/2.0/UDP 172.19.51.21:5060;branch=z9hG4bK-B89D2272;rport
84.    From: <sip:11@pbx.[anonym].net>;tag=4241842629
85.    To: <sip:0108008080800@pbx.[anonym].net;user=phone>
86.    Call-ID: fa59464a61e75b01907f0090332616fc@5
87.    CSeq: 1286550376 INVITE
88.    Contact: <sip:11@172.19.51.21:5060;transport=UDP>
89.   Allow: REGISTER,SUBSCRIBE,NOTIFY,INVITE,ACK,PRACK,OPTIONS,BYE,CANCEL,REFER,INFO,UPDATE,PUBLISH
90.    Content-Length: 514
91.    Content-Type: application/sdp
92.    Max-Forwards: 63
93.    Supported: 100rel,replaces,privacy,timer,from-change,histinfo,answermode
94.    User-Agent: (innovaphone IP240/12r1 sr26 [12.1257/121257/301])
95.    P-Preferred-Identity: <sip:11@pbx.[anonym].net;user=phone>
96.    Recv-Info: dtmf
97.    P-Sig-Options: Sending-Complete,bc=038090a3
98.  
99.    v=0
100.    o=- 5 1 IN IP4 172.19.51.21
101.    s=-
102.    t=0 0
103.    m=audio 16386 RTP/AVP 8 18 4 0 101 13
104.    c=IN IP4 172.19.51.21
105.    a=rtpmap:8 PCMA/8000
106.    a=rtpmap:18 G729/8000
107.    a=rtpmap:4 G723/8000
108.    a=rtpmap:0 PCMU/8000
109.    a=rtpmap:101 telephone-event/8000
110.    a=rtpmap:13 CN/8000
111.    a=fmtp:18 annexb=yes
112.    a=fmtp:101 0-15
113.    a=ptime:20
114.    a=silenceSupp:on - - - -
115.    a=sendrecv
116.    a=ice-ufrag:w7Ce
117.    a=ice-pwd:VWGNhMKhGBOF4qSOrfWHP7
118.    a=candidate:1 1 UDP 2130569471 172.19.51.21 16386 typ host
119.    a=candidate:1 2 UDP 2130569726 172.19.51.21 16387 typ host
120.    ------------------------------------------------------------------------
121. 2018-11-10 23:52:59.075716 [DEBUG] sofia.c:2522 Re-attaching to session 4ef5163f-777a-413d-8ba7-5a983d75f668
122. 2018-11-10 23:52:59.075716 [DEBUG] sofia.c:10080 sofia/internal/11@pbx.[anonym].net receiving invite from 172.19.51.21:5060 version: 1.8.2 -3-a98a958ac3 64bit
123. 2018-11-10 23:52:59.075716 [DEBUG] sofia.c:10251 IP 172.19.51.21 Rejected by acl "domains". Falling back to Digest auth.
124. 2018-11-10 23:52:59.135683 [DEBUG] sofia.c:7291 Channel sofia/internal/11@pbx.[anonym].net entering state [received][100]
125. 2018-11-10 23:52:59.135683 [DEBUG] sofia.c:7301 Remote SDP:
126. v=0
127. o=- 5 1 IN IP4 172.19.51.21
128. s=-
129. t=0 0
130. m=audio 16386 RTP/AVP 8 18 4 0 101 13
131. c=IN IP4 172.19.51.21
132. a=rtpmap:8 PCMA/8000
133. a=rtpmap:18 G729/8000
134. a=fmtp:18 annexb=yes
135. a=rtpmap:4 G723/8000
136. a=rtpmap:0 PCMU/8000
137. a=rtpmap:101 telephone-event/8000
138. a=fmtp:101 0-15
139. a=rtpmap:13 CN/8000
140. a=ptime:20
141. a=silenceSupp:on - - - -
142. a=ice-ufrag:w7Ce
143. a=ice-pwd:VWGNhMKhGBOF4qSOrfWHP7
144. a=candidate:1 1 UDP 2130569471 172.19.51.21 16386 typ host
145. a=candidate:1 2 UDP 2130569726 172.19.51.21 16387 typ host
146.  
147. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
148. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
149. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
150. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
151. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
152. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
153. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
154. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G723:4:8000:20:6300:1]/[opus:116:48000:20:0:1]
155. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G723:4:8000:20:6300:1]/[G722:9:8000:20:64000:1]
156. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G723:4:8000:20:6300:1]/[PCMA:8:8000:20:64000:1]
157. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
158. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
159. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
160. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5394 Set telephone-event payload to 101@8000
161. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:3781 Set Codec sofia/internal/11@pbx.[anonym].net PCMA/8000 20 ms 160 samples 64000 bits 1 channels
162. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_codec.c:111 sofia/internal/11@pbx.[anonym].net Original read codec set to PCMA:8
163. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: UDP type: host addr: 172.19.51.21:16386
164. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 2 proto: UDP type: host addr: 172.19.51.21:16387
165. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:4256 Searching for rtp candidate.
166. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:4265 Choose rtp candidate, index 0, 172.19.51.21:16386
167. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:4031 sofia/internal/11@pbx.[anonym].net choosing family v4
168. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:4256 Searching for rtcp candidate.
169. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:4265 Choose rtcp candidate, index 0, 172.19.51.21:16387
170. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:4031 sofia/internal/11@pbx.[anonym].net choosing family v4
171. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:4328 setting remote audio ice addr to index 0 172.19.51.21:16386 based on candidate
172. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:4363 Setting remote rtcp audio addr to 172.19.51.21:16387 based on candidate
173. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5737 Set telephone-event payload to 101@8000
174. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_media.c:5795 sofia/internal/11@pbx.[anonym].net Set 2833 dtmf send payload to 101 recv payload to 101
175. 2018-11-10 23:52:59.135683 [DEBUG] sofia.c:7716 (sofia/internal/11@pbx.[anonym].net) State Change CS_NEW -> CS_INIT
176. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@pbx.[anonym].net) Running State Change CS_INIT (Cur 1 Tot 1)
177. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/11@pbx.[anonym].net) State INIT
178. 2018-11-10 23:52:59.135683 [DEBUG] mod_sofia.c:93 sofia/internal/11@pbx.[anonym].net SOFIA INIT
179. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_state_machine.c:40 sofia/internal/11@pbx.[anonym].net Standard INIT
180. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/11@pbx.[anonym].net) State Change CS_INIT -> CS_ROUTING
181. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/11@pbx.[anonym].net) State INIT going to sleep
182. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@pbx.[anonym].net) Running State Change CS_ROUTING (Cur 1 Tot 1)
183. 2018-11-10 23:52:59.135683 [DEBUG] switch_channel.c:2249 (sofia/internal/11@pbx.[anonym].net) Callstate Change DOWN -> RINGING
184. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/11@pbx.[anonym].net) State ROUTING
185. 2018-11-10 23:52:59.135683 [DEBUG] mod_sofia.c:154 sofia/internal/11@pbx.[anonym].net SOFIA ROUTING
186. 2018-11-10 23:52:59.135683 [DEBUG] switch_core_state_machine.c:236 sofia/internal/11@pbx.[anonym].net Standard ROUTING
187. 2018-11-10 23:52:59.135683 [INFO] mod_dialplan_xml.c:637 Processing 11 <11>->0108008080800 in context pbx.[anonym].net
188. send 301 bytes to udp/[172.19.51.21]:5060 at 23:52:59.140116:
189.    ------------------------------------------------------------------------
190.    SIP/2.0 100 Trying
191.    Via: SIP/2.0/UDP 172.19.51.21:5060;branch=z9hG4bK-B89D2272;rport=5060
192.    From: <sip:11@pbx.[anonym].net>;tag=4241842629
193.    To: <sip:0108008080800@pbx.[anonym].net;user=phone>
194.    Call-ID: fa59464a61e75b01907f0090332616fc@5
195.    CSeq: 1286550376 INVITE
196.    User-Agent: FreeSWITCH
197.    Content-Length: 0
198.  
199.    ------------------------------------------------------------------------
200. Dialplan: sofia/internal/11@pbx.[anonym].net parsing [pbx.[anonym].net->user_exists] continue=true
201. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [user_exists] () =~ // break=on-false
202. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
203. EXECUTE sofia/internal/11@pbx.[anonym].net set(user_exists=false)
204. 2018-11-10 23:52:59.215661 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [user_exists]=[false]
205. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
206. Dialplan: sofia/internal/11@pbx.[anonym].net parsing [pbx.[anonym].net->caller-details] continue=true
207. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [caller-details] ${caller_destination}() =~ /^$/ break=never
208. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(caller_destination=${destination_number}) INLINE
209. EXECUTE sofia/internal/11@pbx.[anonym].net set(caller_destination=0108008080800)
210. 2018-11-10 23:52:59.235663 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [caller_destination]=[0108008080800]
211. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(caller_id_name=${caller_id_name}) INLINE
212. EXECUTE sofia/internal/11@pbx.[anonym].net set(caller_id_name=11)
213. 2018-11-10 23:52:59.235663 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [caller_id_name]=[11]
214. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(caller_id_number=${caller_id_number}) INLINE
215. EXECUTE sofia/internal/11@pbx.[anonym].net set(caller_id_number=11)
216. 2018-11-10 23:52:59.235663 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [caller_id_number]=[11]
217. Dialplan: sofia/internal/11@pbx.[anonym].net parsing [pbx.[anonym].net->variables] continue=true
218. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [variables] () =~ // break=on-false
219. Dialplan: sofia/internal/11@pbx.[anonym].net Action export(origination_callee_id_name=${destination_number})
220. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
221. Dialplan: sofia/internal/11@pbx.[anonym].net parsing [pbx.[anonym].net->call-direction] continue=true
222. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
223. Dialplan: sofia/internal/11@pbx.[anonym].net ANTI-Action export(call_direction=local)
224. Dialplan: sofia/internal/11@pbx.[anonym].net parsing [pbx.[anonym].net->user_record] continue=true
225. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [user_record] () =~ // break=on-false
226. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
227. EXECUTE sofia/internal/11@pbx.[anonym].net set(user_record=)
228. 2018-11-10 23:52:59.275663 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [user_record]=[UNDEF]
229. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
230. EXECUTE sofia/internal/11@pbx.[anonym].net set(from_user_exists=true)
231. 2018-11-10 23:52:59.295664 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [from_user_exists]=[true]
232. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
233. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
234. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
235. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
236. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
237. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
238. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
239. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
240. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
241. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
242. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
243. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
244. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE
245. EXECUTE sofia/internal/11@pbx.[anonym].net set(from_user_record=all)
246. 2018-11-10 23:52:59.315667 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [from_user_record]=[all]
247. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
248. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [user_record] ${from_user_record}(all) =~ /^all$/ break=never
249. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(record_session=true) INLINE
250. EXECUTE sofia/internal/11@pbx.[anonym].net set(record_session=true)
251. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [record_session]=[true]
252. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
253. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
254. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^inbound$/ break=never
255. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
256. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
257. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^outbound$/ break=never
258. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
259. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
260. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^local$/ break=never
261. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [user_record] ${record_session}(true) =~ /^true$/ break=on-false
262. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(record_path=${recordings_dir}/${domain_name}/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}) INLINE
263. EXECUTE sofia/internal/11@pbx.[anonym].net set(record_path=/var/lib/freeswitch/recordings/pbx.[anonym].net/archive/2018/Nov/10)
264. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [record_path]=[/var/lib/freeswitch/recordings/pbx.[anonym].net/archive/2018/Nov/10]
265. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(record_name=${uuid}.${record_ext}) INLINE
266. EXECUTE sofia/internal/11@pbx.[anonym].net set(record_name=4ef5163f-777a-413d-8ba7-5a983d75f668.wav)
267. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [record_name]=[4ef5163f-777a-413d-8ba7-5a983d75f668.wav]
268. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(recording_follow_transfer=true) INLINE
269. EXECUTE sofia/internal/11@pbx.[anonym].net set(recording_follow_transfer=true)
270. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [recording_follow_transfer]=[true]
271. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(record_append=true) INLINE
272. EXECUTE sofia/internal/11@pbx.[anonym].net set(record_append=true)
273. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [record_append]=[true]
274. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(record_in_progress=true) INLINE
275. EXECUTE sofia/internal/11@pbx.[anonym].net set(record_in_progress=true)
276. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [record_in_progress]=[true]
277. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(${uuid_record ${uuid} start ${record_path}/${record_name}})
278. Dialplan: sofia/internal/11@pbx.[anonym].net parsing [pbx.[anonym].net->redial] continue=true
279. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [redial] destination_number(0108008080800) =~ /^(redial|\*870)$/ break=on-true
280. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [redial] () =~ // break=never
281. Dialplan: sofia/internal/11@pbx.[anonym].net Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
282. Dialplan: sofia/internal/11@pbx.[anonym].net parsing [pbx.[anonym].net->speed_dial] continue=false
283. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [speed_dial] destination_number(0108008080800) =~ /^\*0(.*)$/ break=on-false
284. Dialplan: sofia/internal/11@pbx.[anonym].net parsing [pbx.[anonym].net->default_caller_id] continue=true
285. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
286. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
287. EXECUTE sofia/internal/11@pbx.[anonym].net set(emergency_caller_id_name=)
288. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [emergency_caller_id_name]=[UNDEF]
289. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
290. EXECUTE sofia/internal/11@pbx.[anonym].net set(emergency_caller_id_number=)
291. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [emergency_caller_id_number]=[UNDEF]
292. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
293. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
294. EXECUTE sofia/internal/11@pbx.[anonym].net set(outbound_caller_id_name=)
295. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [outbound_caller_id_name]=[UNDEF]
296. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
297. EXECUTE sofia/internal/11@pbx.[anonym].net set(outbound_caller_id_number=)
298. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [outbound_caller_id_number]=[UNDEF]
299. Dialplan: sofia/internal/11@pbx.[anonym].net parsing [pbx.[anonym].net->49[anonym]156.d] continue=false
300. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [49[anonym]156.d] ${user_exists}(false) =~ /false/ break=on-false
301. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (FAIL) [49[anonym]156.d] ${sip_from_user}(11) =~ /12/ break=on-false
302. Dialplan: sofia/internal/11@pbx.[anonym].net parsing [pbx.[anonym].net->+49[anonym]206.01d] continue=false
303. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [+49[anonym]206.01d] ${user_exists}(false) =~ /false/ break=on-false
304. Dialplan: sofia/internal/11@pbx.[anonym].net Regex (PASS) [+49[anonym]206.01d] destination_number(0108008080800) =~ /^01(\d+)$/ break=on-false
305. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(sip_h_X-accountcode=${accountcode})
306. Dialplan: sofia/internal/11@pbx.[anonym].net Action export(call_direction=outbound)
307. Dialplan: sofia/internal/11@pbx.[anonym].net Action unset(call_timeout)
308. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(hangup_after_bridge=true)
309. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(effective_caller_id_name=${outbound_caller_id_name})
310. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(effective_caller_id_number=${outbound_caller_id_number})
311. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(inherit_codec=true)
312. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(ignore_display_updates=true)
313. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(callee_id_number=08008080800)
314. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(continue_on_fail=true)
315. Dialplan: sofia/internal/11@pbx.[anonym].net Action set(outbound_prefix=01)
316. Dialplan: sofia/internal/11@pbx.[anonym].net Action bridge(sofia/gateway/737888c4-6119-4b50-9b6d-176732c5fb2d/08008080800)
317. 2018-11-10 23:52:59.335699 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/11@pbx.[anonym].net) State Change CS_ROUTING -> CS_EXECUTE
318. 2018-11-10 23:52:59.335699 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/11@pbx.[anonym].net) State ROUTING going to sleep
319. 2018-11-10 23:52:59.335699 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@pbx.[anonym].net) Running State Change CS_EXECUTE (Cur 1 Tot 1)
320. 2018-11-10 23:52:59.335699 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/11@pbx.[anonym].net) State EXECUTE
321. 2018-11-10 23:52:59.335699 [DEBUG] mod_sofia.c:209 sofia/internal/11@pbx.[anonym].net SOFIA EXECUTE
322. 2018-11-10 23:52:59.335699 [DEBUG] switch_core_state_machine.c:328 sofia/internal/11@pbx.[anonym].net Standard EXECUTE
323. EXECUTE sofia/internal/11@pbx.[anonym].net export(origination_callee_id_name=0108008080800)
324. 2018-11-10 23:52:59.335699 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[0108008080800]
325. EXECUTE sofia/internal/11@pbx.[anonym].net set(RFC2822_DATE=Sat, 10 Nov 2018 23:52:59 +0100)
326. 2018-11-10 23:52:59.335699 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [RFC2822_DATE]=[Sat, 10 Nov 2018 23:52:59 +0100]
327. EXECUTE sofia/internal/11@pbx.[anonym].net export(call_direction=local)
328. 2018-11-10 23:52:59.335699 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[local]
329. 2018-11-10 23:52:59.355691 [INFO] switch_ivr_async.c:2557 Sending early media
330. 2018-11-10 23:52:59.355691 [DEBUG] switch_core_media.c:8511 AUDIO RTP [sofia/internal/11@pbx.[anonym].net] 172.19.50.3 port 18920 -> 172.19.51.21 port 16386 codec: 8 ms: 20
331. 2018-11-10 23:52:59.355691 [DEBUG] switch_rtp.c:4300 Starting timer [soft] 160 bytes per 20ms
332. send 1303 bytes to udp/[172.19.51.21]:5060 at 23:52:59.358752:
333.    ------------------------------------------------------------------------
334.    NOTIFY sip:11@172.19.51.21:5060;transport=UDP SIP/2.0
335.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bK9c79mgpBya7eB
336.    Max-Forwards: 70
337.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=ldmvNmA2D3ym
338.    To: <sip:11@pbx.[anonym].net>;tag=1898982082
339.    Call-ID: d5abfc275ee75b015bde0090332616fc@2
340.    CSeq: 1356458951 NOTIFY
341.    Contact: <sip:11@172.19.50.3:5060>
342.    User-Agent: FreeSWITCH
343.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
344.    Supported: timer, path, replaces
345.    Event: presence
346.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
347.    Subscription-State: active;expires=20
348.    Content-Type: application/pidf+xml
349.    Content-Length: 505
350.  
351.    <?xml version="1.0" encoding="ISO-8859-1"?>
352.    <presence xmlns='urn:ietf:params:xml:ns:pidf'
353.    xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
354.    xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
355.    xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:11@pbx.[anonym].net'>
356.     <tuple id='t6a5ed77e'>
357.      <status>
358.       <basic>open</basic>
359.      </status>
360.     </tuple>
361.     <dm:person id='p06360c4a'>
362.      <rpid:activities>
363.       <rpid:on-the-phone/>
364.      </rpid:activities>
365.      <dm:note>Call 0108008080800</dm:note>
366.     </dm:person>
367.    </presence>
368.  
369.    ------------------------------------------------------------------------
370. send 1304 bytes to udp/[172.19.51.21]:5060 at 23:52:59.359834:
371.    ------------------------------------------------------------------------
372.    NOTIFY sip:11@172.19.51.21:5060;transport=UDP SIP/2.0
373.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bKap02pB7eUKX1p
374.    Max-Forwards: 70
375.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=G3MK4pPAsqMh
376.    To: <sip:11@pbx.[anonym].net>;tag=4241842626
377.    Call-ID: f22da23761e75b01897f0090332616fc@2
378.    CSeq: 1356458952 NOTIFY
379.    Contact: <sip:11@172.19.50.3:5060>
380.    User-Agent: FreeSWITCH
381.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
382.    Supported: timer, path, replaces
383.    Event: presence
384. 2018-11-10 23:52:59.355691 [INFO] switch_core_media.c:8690 Activating Audio ICE
385.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
386.    Subscription-State: active;expires=100
387.    Content-Type: application/pidf+xml
388.    Content-Length: 505
389.  
390.    <?xml version="1.0" encoding="ISO-8859-1"?>
391.    <presence xmlns='urn:ietf:params:xml:ns:pidf'
392.    xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
393.    xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
394.    xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:11@pbx.[anonym].net'>
395. 2018-11-10 23:52:59.355691 [NOTICE] switch_rtp.c:4799 Activating RTP audio ICE: w7Ce:S6hEQ7A2aexCjyqk 172.19.51.21:16386
396.     <tuple id='t6a5ed77e'>
397.      <status>
398.       <basic>open</basic>
399.      </status>
400.     </tuple>
401. 2018-11-10 23:52:59.355691 [DEBUG] switch_core_media.c:8815 sofia/internal/11@pbx.[anonym].net Set 2833 dtmf send payload to 101
402.     <dm:person id='p06360c4a'>
403.      <rpid:activities>
404.       <rpid:on-the-phone/>
405.      </rpid:activities>
406. 2018-11-10 23:52:59.355691 [DEBUG] switch_core_media.c:8822 sofia/internal/11@pbx.[anonym].net Set 2833 dtmf receive payload to 101
407.      <dm:note>Call 0108008080800</dm:note>
408.     </dm:person>
409.    </presence>
410.  
411.    ------------------------------------------------------------------------
412. 2018-11-10 23:52:59.355691 [DEBUG] switch_core_media.c:8845 sofia/internal/11@pbx.[anonym].net Set rtp dtmf delay to 40
413. 2018-11-10 23:52:59.355691 [DEBUG] switch_core_media.c:8851 Set comfort noise payload to 13
414. 2018-11-10 23:52:59.355691 [DEBUG] mod_sofia.c:2514 Ring SDP:
415. v=0
416. o=FreeSWITCH 1541871459 1541871460 IN IP4 172.19.50.3
417. s=FreeSWITCH
418. c=IN IP4 172.19.50.3
419. t=0 0
420. a=msid-semantic: WMS v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX
421. m=audio 18920 RTP/AVP 8 101 13
422. a=rtpmap:8 PCMA/8000
423. a=rtpmap:101 telephone-event/8000
424. a=fmtp:101 0-16
425. a=rtpmap:13 CN/8000
426. a=ptime:20
427. a=sendrecv
428. a=ice-ufrag:S6hEQ7A2aexCjyqk
429. a=ice-pwd:fJfStkKFnmh9ypggmnK3kaVl
430. a=candidate:3769281485 1 udp 659136 172.19.50.3 18920 typ host generation 0
431. a=candidate:3769281485 2 udp 659135 172.19.50.3 18921 typ host generation 0
432. a=end-of-candidates
433. a=ssrc:1072399891 cname:aQt5MUf2mcLLWmig
434. a=ssrc:1072399891 msid:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX a0
435. a=ssrc:1072399891 mslabel:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX
436. a=ssrc:1072399891 label:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaXa0
437.  
438. 2018-11-10 23:52:59.355691 [NOTICE] mod_sofia.c:2517 Pre-Answer sofia/internal/11@pbx.[anonym].net!
439. recv 353 bytes from udp/[172.19.51.21]:5060 at 23:52:59.362385:
440.    ------------------------------------------------------------------------
441.    SIP/2.0 200 OK
442.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bK9c79mgpBya7eB;received=172.19.50.3
443.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=ldmvNmA2D3ym
444.    To: <sip:11@pbx.[anonym].net>;tag=1898982082
445.    Call-ID: d5abfc275ee75b015bde0090332616fc@2
446.    CSeq: 1356458951 NOTIFY
447.    Content-Length: 0
448.    Server: (innovaphone IP240/12r1 sr26 [12.1257/121257/301])
449.  
450.    ------------------------------------------------------------------------
451. 2018-11-10 23:52:59.355691 [DEBUG] switch_channel.c:3482 (sofia/internal/11@pbx.[anonym].net) Callstate Change RINGING -> EARLY
452. send 1625 bytes to udp/[172.19.51.21]:5060 at 23:52:59.366524:
453.    ------------------------------------------------------------------------
454.    SIP/2.0 183 Session Progress
455.    Via: SIP/2.0/UDP 172.19.51.21:5060;branch=z9hG4bK-B89D2272;rport=5060
456.    From: <sip:11@pbx.[anonym].net>;tag=4241842629
457.    To: <sip:0108008080800@pbx.[anonym].net;user=phone>;tag=c0cZ0e0SUSKNK
458.    Call-ID: fa59464a61e75b01907f0090332616fc@5
459.    CSeq: 1286550376 INVITE
460.    Contact: <sip:0108008080800@172.19.50.3:5060;transport=udp>
461.    User-Agent: FreeSWITCH
462.    Accept: application/sdp
463.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
464.    Supported: timer, path, replaces
465.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
466.    Content-Type: application/sdp
467.    Content-Disposition: session
468.    Content-Length: 760
469.    P-Asserted-Identity: "0108008080800" <sip:0108008080800@pbx.[anonym].net>
470.  
471.    v=0
472.    o=FreeSWITCH 1541871459 1541871460 IN IP4 172.19.50.3
473.    s=FreeSWITCH
474.    c=IN IP4 172.19.50.3
475.    t=0 0
476.    a=msid-semantic: WMS v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX
477.    m=audio 18920 RTP/AVP 8 101 13
478.    a=rtpmap:8 PCMA/8000
479.    a=rtpmap:101 telephone-event/8000
480.    a=fmtp:101 0-16
481.    a=rtpmap:13 CN/8000
482.    a=ptime:20
483.    a=ice-ufrag:S6hEQ7A2aexCjyqk
484.    a=ice-pwd:fJfStkKFnmh9ypggmnK3kaVl
485.    a=candidate:3769281485 1 udp 659136 172.19.50.3 18920 typ host generation 0
486.    a=candidate:3769281485 2 udp 659135 172.19.50.3 18921 typ host generation 0
487.    a=end-of-candidates
488.    a=ssrc:1072399891 cname:aQt5MUf2mcLLWmig
489.    a=ssrc:1072399891 msid:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX a0
490.    a=ssrc:1072399891 mslabel:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX
491.    a=ssrc:1072399891 label:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaXa0
492.    ------------------------------------------------------------------------
493. recv 353 bytes from udp/[172.19.51.21]:5060 at 23:52:59.367778:
494.    ------------------------------------------------------------------------
495.    SIP/2.0 200 OK
496.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bKap02pB7eUKX1p;received=172.19.50.3
497.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=G3MK4pPAsqMh
498.    To: <sip:11@pbx.[anonym].net>;tag=4241842626
499.    Call-ID: f22da23761e75b01897f0090332616fc@2
500.    CSeq: 1356458952 NOTIFY
501.    Content-Length: 0
502.    Server: (innovaphone IP240/12r1 sr26 [12.1257/121257/301])
503.  
504.    ------------------------------------------------------------------------
505. 2018-11-10 23:52:59.375660 [DEBUG] switch_ivr_async.c:1319 Record session sample rate: 8000 -> 8000
506. 2018-11-10 23:52:59.375660 [DEBUG] switch_core_media_bug.c:962 Attaching BUG to sofia/internal/11@pbx.[anonym].net
507. 2018-11-10 23:52:59.375660 [DEBUG] sofia.c:7291 Channel sofia/internal/11@pbx.[anonym].net entering state [early][183]
508. EXECUTE sofia/internal/11@pbx.[anonym].net set(+OK Success
509. )
510. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [+OK Success
511. ]=[UNDEF]
512. EXECUTE sofia/internal/11@pbx.[anonym].net hash(insert/pbx.[anonym].net-last_dial/11/0108008080800)
513. EXECUTE sofia/internal/11@pbx.[anonym].net set(sip_h_X-accountcode=)
514. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [sip_h_X-accountcode]=[UNDEF]
515. EXECUTE sofia/internal/11@pbx.[anonym].net export(call_direction=outbound)
516. 2018-11-10 23:52:59.375660 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[outbound]
517. EXECUTE sofia/internal/11@pbx.[anonym].net unset(call_timeout)
518. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1743 UNSET [call_timeout]
519. EXECUTE sofia/internal/11@pbx.[anonym].net set(hangup_after_bridge=true)
520. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [hangup_after_bridge]=[true]
521. EXECUTE sofia/internal/11@pbx.[anonym].net set(effective_caller_id_name=)
522. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [effective_caller_id_name]=[UNDEF]
523. EXECUTE sofia/internal/11@pbx.[anonym].net set(effective_caller_id_number=)
524. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [effective_caller_id_number]=[UNDEF]
525. EXECUTE sofia/internal/11@pbx.[anonym].net set(inherit_codec=true)
526. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [inherit_codec]=[true]
527. EXECUTE sofia/internal/11@pbx.[anonym].net set(ignore_display_updates=true)
528. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [ignore_display_updates]=[true]
529. EXECUTE sofia/internal/11@pbx.[anonym].net set(callee_id_number=08008080800)
530. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [callee_id_number]=[08008080800]
531. EXECUTE sofia/internal/11@pbx.[anonym].net set(continue_on_fail=true)
532. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [continue_on_fail]=[true]
533. EXECUTE sofia/internal/11@pbx.[anonym].net set(outbound_prefix=01)
534. 2018-11-10 23:52:59.375660 [DEBUG] mod_dptools.c:1598 SET sofia/internal/11@pbx.[anonym].net [outbound_prefix]=[01]
535. EXECUTE sofia/internal/11@pbx.[anonym].net bridge(sofia/gateway/737888c4-6119-4b50-9b6d-176732c5fb2d/08008080800)
536. 2018-11-10 23:52:59.395667 [DEBUG] switch_channel.c:1250 sofia/internal/11@pbx.[anonym].net EXPORTING[export_vars] [domain_name]=[pbx.[anonym].net] to event
537. 2018-11-10 23:52:59.395667 [DEBUG] switch_channel.c:1250 sofia/internal/11@pbx.[anonym].net EXPORTING[export_vars] [origination_callee_id_name]=[0108008080800] to event
538. 2018-11-10 23:52:59.395667 [DEBUG] switch_channel.c:1250 sofia/internal/11@pbx.[anonym].net EXPORTING[export_vars] [call_direction]=[outbound] to event
539. 2018-11-10 23:52:59.395667 [DEBUG] switch_channel.c:1250 sofia/internal/11@pbx.[anonym].net EXPORTING[export_vars] [call_direction]=[outbound] to event
540. 2018-11-10 23:52:59.395667 [DEBUG] switch_ivr_originate.c:2204 Parsing global variables
541. 2018-11-10 23:52:59.395667 [NOTICE] switch_channel.c:1104 New Channel sofia/external/08008080800 [bf9b0974-f3f7-48d8-86da-9e79668319fb]
542. 2018-11-10 23:52:59.395667 [DEBUG] mod_sofia.c:5028 (sofia/external/08008080800) State Change CS_NEW -> CS_INIT
543. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08008080800) Running State Change CS_INIT (Cur 2 Tot 2)
544. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:627 (sofia/external/08008080800) State INIT
545. 2018-11-10 23:52:59.395667 [DEBUG] mod_sofia.c:93 sofia/external/08008080800 SOFIA INIT
546. 2018-11-10 23:52:59.395667 [DEBUG] sofia_glue.c:1299 sofia/external/08008080800 sending invite version: 1.8.2 -3-a98a958ac3 64bit
547. Local SDP:
548. v=0
549. o=FreeSWITCH 1541866197 1541866198 IN IP4 172.19.50.3
550. s=FreeSWITCH
551. c=IN IP4 172.19.50.3
552. t=0 0
553. m=audio 24182 RTP/AVP 8 101 13
554. a=rtpmap:8 PCMA/8000
555. a=rtpmap:101 telephone-event/8000
556. a=fmtp:101 0-16
557. a=rtpmap:13 CN/8000
558. a=ptime:20
559. a=sendrecv
560.  
561. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:40 sofia/external/08008080800 Standard INIT
562. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:48 (sofia/external/08008080800) State Change CS_INIT -> CS_ROUTING
563. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:627 (sofia/external/08008080800) State INIT going to sleep
564. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08008080800) Running State Change CS_ROUTING (Cur 2 Tot 2)
565. 2018-11-10 23:52:59.395667 [DEBUG] sofia.c:7291 Channel sofia/external/08008080800 entering state [calling][0]
566. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:643 (sofia/external/08008080800) State ROUTING
567. 2018-11-10 23:52:59.395667 [DEBUG] mod_sofia.c:154 sofia/external/08008080800 SOFIA ROUTING
568. 2018-11-10 23:52:59.395667 [DEBUG] switch_ivr_originate.c:67 (sofia/external/08008080800) State Change CS_ROUTING -> CS_CONSUME_MEDIA
569. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:643 (sofia/external/08008080800) State ROUTING going to sleep
570. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08008080800) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 2)
571. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:662 (sofia/external/08008080800) State CONSUME_MEDIA
572. 2018-11-10 23:52:59.395667 [DEBUG] switch_core_state_machine.c:662 (sofia/external/08008080800) State CONSUME_MEDIA going to sleep
573. 2018-11-10 23:52:59.395667 [WARNING] switch_rtp.c:974 sofia/internal/11@pbx.[anonym].net got audio stun binding response 487
574. 2018-11-10 23:52:59.395667 [WARNING] switch_rtp.c:985 audio STUN Changing role to CONTROLLED
575. send 1127 bytes to udp/[217.0.27.32]:5060 at 23:52:59.411318:
576.    ------------------------------------------------------------------------
577.    INVITE sip:08008080800@tel.t-online.de SIP/2.0
578.    Via: SIP/2.0/UDP 172.19.50.3:5080;rport;branch=z9hG4bKy3Np48ZBt0vmK
579.    Max-Forwards: 62
580.    From: "11" <sip:+49[anonym]206@tel.t-online.de>;tag=t2eppXypav9yK
581.    To: <sip:08008080800@tel.t-online.de>
582.    Call-ID: 3657973f-5fde-1237-1193-000db9478a88
583.    CSeq: 130609125 INVITE
584.    Contact: <sip:gw+737888c4-6119-4b50-9b6d-176732c5fb2d@172.19.50.3:5080;transport=udp;gw=737888c4-6119-4b50-9b6d-176732c5fb2d>
585.    User-Agent: FreeSWITCH
586.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
587.    Supported: timer, path, replaces
588.    Allow-Events: talk, hold, conference, refer
589.    Content-Type: application/sdp
590.    Content-Disposition: session
591.    Content-Length: 242
592.    P-Sig-Options: Sending-Complete,bc=038090a3
593.    X-FS-Support: update_display,send_info
594.    Remote-Party-ID: "11" <sip:11@tel.t-online.de>;party=calling;screen=yes;privacy=off
595.  
596.    v=0
597.    o=FreeSWITCH 1541866197 1541866198 IN IP4 172.19.50.3
598.    s=FreeSWITCH
599.    c=IN IP4 172.19.50.3
600.    t=0 0
601.    m=audio 24182 RTP/AVP 8 101 13
602.    a=rtpmap:8 PCMA/8000
603.    a=rtpmap:101 telephone-event/8000
604.    a=fmtp:101 0-16
605.    a=rtpmap:13 CN/8000
606.    a=ptime:20
607.    ------------------------------------------------------------------------
608. 2018-11-10 23:52:59.415691 [DEBUG] switch_ivr_async.c:1608 No silence detection configured; assuming start of speech
609. recv 520 bytes from udp/[217.0.27.32]:5060 at 23:52:59.526494:
610.    ------------------------------------------------------------------------
611.    SIP/2.0 407 Proxy Authentication Required 02035034C
612.    Via: SIP/2.0/UDP 172.19.50.3:5080;received=172.19.50.3;rport=5080;branch=z9hG4bKy3Np48ZBt0vmK
613.    To: <sip:08008080800@tel.t-online.de>;tag=h7g4Esbg_c903247e015827eb90d40c3d01b3c836
614.    From: "11" <sip:+49[anonym]206@tel.t-online.de>;tag=t2eppXypav9yK
615.    Call-ID: 3657973f-5fde-1237-1193-000db9478a88
616.    CSeq: 130609125 INVITE
617.    Content-Length: 0
618.    Proxy-Authenticate: Digest nonce="F048CDD55761E75B00000000CFF40400",realm="tel.t-online.de",algorithm=MD5,qop="auth",stale=true
619.  
620.    ------------------------------------------------------------------------
621. send 372 bytes to udp/[217.0.27.32]:5060 at 23:52:59.527072:
622.    ------------------------------------------------------------------------
623.    ACK sip:08008080800@tel.t-online.de SIP/2.0
624.    Via: SIP/2.0/UDP 172.19.50.3:5080;rport;branch=z9hG4bKy3Np48ZBt0vmK
625.    Max-Forwards: 62
626.    From: "11" <sip:+49[anonym]206@tel.t-online.de>;tag=t2eppXypav9yK
627.    To: <sip:08008080800@tel.t-online.de>;tag=h7g4Esbg_c903247e015827eb90d40c3d01b3c836
628.    Call-ID: 3657973f-5fde-1237-1193-000db9478a88
629.    CSeq: 130609125 ACK
630.    Content-Length: 0
631.  
632.    ------------------------------------------------------------------------
633. send 1402 bytes to udp/[217.0.27.32]:5060 at 23:52:59.528221:
634.    ------------------------------------------------------------------------
635.    INVITE sip:08008080800@tel.t-online.de SIP/2.0
636.    Via: SIP/2.0/UDP 172.19.50.3:5080;rport;branch=z9hG4bKZcFF63gFQ9j7e
637.    Max-Forwards: 62
638.    From: "11" <sip:+49[anonym]206@tel.t-online.de>;tag=t2eppXypav9yK
639.    To: <sip:08008080800@tel.t-online.de>
640.    Call-ID: 3657973f-5fde-1237-1193-000db9478a88
641.    CSeq: 130609126 INVITE
642.    Contact: <sip:gw+737888c4-6119-4b50-9b6d-176732c5fb2d@172.19.50.3:5080;transport=udp;gw=737888c4-6119-4b50-9b6d-176732c5fb2d>
643.    User-Agent: FreeSWITCH
644.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
645.    Supported: timer, path, replaces
646.    Allow-Events: talk, hold, conference, refer
647.    Proxy-Authorization: Digest username="551124935083", realm="tel.t-online.de", nonce="F048CDD55761E75B00000000CFF40400", cnonce="NmqTBV/eEjeTEQANuUeKiA", algorithm=MD5, uri="sip:08008080800@tel.t-online.de", response="e69e104546ed1892e1997b18dcc9bd29", qop=auth, nc=00000001
648.    Content-Type: application/sdp
649.    Content-Disposition: session
650.    Content-Length: 242
651.    P-Sig-Options: Sending-Complete,bc=038090a3
652.    X-FS-Support: update_display,send_info
653.    Remote-Party-ID: "11" <sip:11@tel.t-online.de>;party=calling;screen=yes;privacy=off
654.  
655.    v=0
656.    o=FreeSWITCH 1541866197 1541866198 IN IP4 172.19.50.3
657.    s=FreeSWITCH
658.    c=IN IP4 172.19.50.3
659.    t=0 0
660.    m=audio 24182 RTP/AVP 8 101 13
661.    a=rtpmap:8 PCMA/8000
662.    a=rtpmap:101 telephone-event/8000
663.    a=fmtp:101 0-16
664.    a=rtpmap:13 CN/8000
665.    a=ptime:20
666.    ------------------------------------------------------------------------
667. 2018-11-10 23:52:59.516166 [DEBUG] sofia.c:7291 Channel sofia/external/08008080800 entering state [calling][0]
668. recv 312 bytes from udp/[217.0.27.32]:5060 at 23:52:59.740881:
669.    ------------------------------------------------------------------------
670.    SIP/2.0 100 Trying
671.    Via: SIP/2.0/UDP 172.19.50.3:5080;received=172.19.50.3;rport=5080;branch=z9hG4bKZcFF63gFQ9j7e
672.    To: <sip:08008080800@tel.t-online.de>
673.    From: "11" <sip:+49[anonym]206@tel.t-online.de>;tag=t2eppXypav9yK
674.    Call-ID: 3657973f-5fde-1237-1193-000db9478a88
675.    CSeq: 130609126 INVITE
676.    Content-Length: 0
677.  
678.    ------------------------------------------------------------------------
679. recv 851 bytes from udp/[217.0.27.32]:5060 at 23:52:59.814986:
680.    ------------------------------------------------------------------------
681.    SIP/2.0 183 Session Progress
682.    Via: SIP/2.0/UDP 172.19.50.3:5080;received=172.19.50.3;rport=5080;branch=z9hG4bKZcFF63gFQ9j7e
683.    To: <sip:08008080800@tel.t-online.de>;tag=h7g4Esbg_p65555t1541890379m568871c371372549s1_1415273537-177558755
684.    From: "11" <sip:+49[anonym]206@tel.t-online.de>;tag=t2eppXypav9yK
685.    Call-ID: 3657973f-5fde-1237-1193-000db9478a88
686.    CSeq: 130609126 INVITE
687.    Contact: <sip:sgc_c@217.0.27.32;transport=udp>
688.    Record-Route: <sip:217.0.27.32;transport=udp;lr>
689.    P-Early-Media: sendonly
690.    Supported: timer
691.    Content-Type: application/sdp
692.    Content-Length: 217
693.    Allow: UPDATE, PRACK, OPTIONS, BYE, ACK, CANCEL, INVITE, REGISTER
694.  
695.    v=0
696.    o=- 220059467 1415471457 IN IP4 217.0.27.32
697.    s=SIP Call
698.    c=IN IP4 217.0.6.52
699.    t=0 0
700.    m=audio 29556 RTP/AVP 8 101
701.    a=rtpmap:8 PCMA/8000
702.    a=rtpmap:101 telephone-event/8000
703.    a=fmtp:101 0-15
704.    a=ptime:20
705.    a=sendrecv
706.    ------------------------------------------------------------------------
707. 2018-11-10 23:52:59.815679 [DEBUG] sofia.c:7291 Channel sofia/external/08008080800 entering state [proceeding][183]
708. 2018-11-10 23:52:59.815679 [DEBUG] sofia.c:7301 Remote SDP:
709. v=0
710. o=- 220059467 1415471457 IN IP4 217.0.27.32
711. s=SIP Call
712. c=IN IP4 217.0.6.52
713. t=0 0
714. m=audio 29556 RTP/AVP 8 101
715. a=rtpmap:8 PCMA/8000
716. a=rtpmap:101 telephone-event/8000
717. a=fmtp:101 0-15
718. a=ptime:20
719.  
720. 2018-11-10 23:52:59.815679 [NOTICE] sofia.c:7304 Pre-Answer sofia/external/08008080800!
721. 2018-11-10 23:52:59.815679 [DEBUG] switch_channel.c:3482 (sofia/external/08008080800) Callstate Change DOWN -> EARLY
722. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
723. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
724. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_media.c:5394 Set telephone-event payload to 101@8000
725. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_media.c:3781 Set Codec sofia/external/08008080800 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
726. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_codec.c:111 sofia/external/08008080800 Original read codec set to PCMA:8
727. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_media.c:5737 Set telephone-event payload to 101@8000
728. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_media.c:5795 sofia/external/08008080800 Set 2833 dtmf send payload to 101 recv payload to 101
729. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_media.c:8511 AUDIO RTP [sofia/external/08008080800] 172.19.50.3 port 24182 -> 217.0.6.52 port 29556 codec: 8 ms: 20
730. 2018-11-10 23:52:59.815679 [DEBUG] switch_rtp.c:4300 Starting timer [soft] 160 bytes per 20ms
731. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_media.c:8815 sofia/external/08008080800 Set 2833 dtmf send payload to 101
732. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_media.c:8822 sofia/external/08008080800 Set 2833 dtmf receive payload to 101
733. 2018-11-10 23:52:59.815679 [DEBUG] switch_core_media.c:8845 sofia/external/08008080800 Set rtp dtmf delay to 40
734. 2018-11-10 23:52:59.835677 [DEBUG] switch_ivr_originate.c:3798 Originate Resulted in Success: [sofia/external/08008080800]
735. 2018-11-10 23:52:59.835677 [DEBUG] switch_ivr_bridge.c:1782 (sofia/external/08008080800) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
736. 2018-11-10 23:52:59.835677 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08008080800) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 2)
737. 2018-11-10 23:52:59.835677 [DEBUG] switch_core_state_machine.c:653 (sofia/external/08008080800) State EXCHANGE_MEDIA
738. 2018-11-10 23:52:59.835677 [DEBUG] mod_sofia.c:645 SOFIA EXCHANGE_MEDIA
739. 2018-11-10 23:52:59.875661 [DEBUG] switch_rtp.c:7550 Correct audio ip/port confirmed.
740. recv 1120 bytes from udp/[217.0.27.32]:5060 at 23:53:04.615229:
741.    ------------------------------------------------------------------------
742.    SIP/2.0 200 OK
743.    Via: SIP/2.0/UDP 172.19.50.3:5080;received=172.19.50.3;rport=5080;branch=z9hG4bKZcFF63gFQ9j7e
744.    To: <sip:08008080800@tel.t-online.de>;tag=h7g4Esbg_p65555t1541890379m568871c371372549s1_1415273537-177558755
745.    From: "11" <sip:+49[anonym]206@tel.t-online.de>;tag=t2eppXypav9yK
746.    Call-ID: 3657973f-5fde-1237-1193-000db9478a88
747.    CSeq: 130609126 INVITE
748.    Contact: <sip:sgc_c@217.0.27.32;transport=udp>;+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel";transport=udp
749.    Record-Route: <sip:217.0.27.32;transport=udp;lr>
750.    Session-Expires: 1800;refresher=uas
751.    Supported: timer
752.    Content-Type: application/sdp
753.    Content-Length: 217
754.    Session-ID: 36fc5134af312d69d731ebd6afccb1fd
755.    Authentication-Info: qop=auth,rspauth="ed2405023cb4f949fe39f30b77a95e56",cnonce="NmqTBV/eEjeTEQANuUeKiA",nc=00000001
756.   Allow: REGISTER, REFER, NOTIFY, SUBSCRIBE, INFO, PRACK, UPDATE, INVITE, ACK, OPTIONS, CANCEL, BYE
757.  
758.    v=0
759.    o=- 220059467 1415471457 IN IP4 217.0.27.32
760.    s=SIP Call
761.    c=IN IP4 217.0.6.52
762.    t=0 0
763.    m=audio 29556 RTP/AVP 8 101
764.    a=rtpmap:8 PCMA/8000
765.    a=rtpmap:101 telephone-event/8000
766.    a=fmtp:101 0-15
767.    a=ptime:20
768.    a=sendrecv
769.    ------------------------------------------------------------------------
770. 2018-11-10 23:53:04.615671 [DEBUG] sofia.c:7291 Channel sofia/external/08008080800 entering state [completing][200]
771. 2018-11-10 23:53:04.615671 [DEBUG] sofia.c:7298 Duplicate SDP
772. v=0
773. o=- 220059467 1415471457 IN IP4 217.0.27.32
774. s=SIP Call
775. c=IN IP4 217.0.6.52
776. t=0 0
777. m=audio 29556 RTP/AVP 8 101
778. a=rtpmap:8 PCMA/8000
779. a=rtpmap:101 telephone-event/8000
780. a=fmtp:101 0-15
781. a=ptime:20
782.  
783. send 846 bytes to udp/[217.0.27.32]:5060 at 23:53:04.628167:
784.    ------------------------------------------------------------------------
785.    ACK sip:sgc_c@217.0.27.32;transport=udp SIP/2.0
786.    Via: SIP/2.0/UDP 172.19.50.3:5080;rport;branch=z9hG4bK0N877y1jmj9Sa
787.    Route: <sip:217.0.27.32;transport=udp;lr>
788.    Max-Forwards: 70
789.    From: "11" <sip:+49[anonym]206@tel.t-online.de>;tag=t2eppXypav9yK
790.    To: <sip:08008080800@tel.t-online.de>;tag=h7g4Esbg_p65555t1541890379m568871c371372549s1_1415273537-177558755
791.    Call-ID: 3657973f-5fde-1237-1193-000db9478a88
792.    CSeq: 130609126 ACK
793.    Contact: <sip:gw+737888c4-6119-4b50-9b6d-176732c5fb2d@172.19.50.3:5080;transport=udp;gw=737888c4-6119-4b50-9b6d-176732c5fb2d>
794.    Proxy-Authorization: Digest username="551124935083", realm="tel.t-online.de", nonce="F048CDD55761E75B00000000CFF40400", cnonce="NmqTBV/eEjeTEQANuUeKiA", algorithm=MD5, uri="sip:08008080800@tel.t-online.de", response="e69e104546ed1892e1997b18dcc9bd29", qop=auth, nc=00000001
795.    Content-Length: 0
796.  
797.    ------------------------------------------------------------------------
798. 2018-11-10 23:53:04.635681 [DEBUG] sofia.c:7291 Channel sofia/external/08008080800 entering state [ready][200]
799. 2018-11-10 23:53:04.635681 [NOTICE] sofia.c:8370 Channel [sofia/external/08008080800] has been answered
800. 2018-11-10 23:53:04.635681 [DEBUG] switch_channel.c:3781 (sofia/external/08008080800) Callstate Change EARLY -> ACTIVE
801. 2018-11-10 23:53:04.655679 [DEBUG] switch_core_media.c:8494 Audio params are unchanged for sofia/internal/11@pbx.[anonym].net.
802. 2018-11-10 23:53:04.655679 [DEBUG] mod_sofia.c:881 Local SDP sofia/internal/11@pbx.[anonym].net:
803. v=0
804. o=FreeSWITCH 1541871459 1541871461 IN IP4 172.19.50.3
805. s=FreeSWITCH
806. c=IN IP4 172.19.50.3
807. t=0 0
808. a=msid-semantic: WMS v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX
809. m=audio 18920 RTP/AVP 8 101 13
810. a=rtpmap:8 PCMA/8000
811. a=rtpmap:101 telephone-event/8000
812. a=fmtp:101 0-16
813. a=rtpmap:13 CN/8000
814. a=ptime:20
815. a=sendrecv
816. a=ice-ufrag:S6hEQ7A2aexCjyqk
817. a=ice-pwd:fJfStkKFnmh9ypggmnK3kaVl
818. a=candidate:7066243327 1 udp 659136 172.19.50.3 18920 typ host generation 0
819. a=candidate:7066243327 2 udp 659135 172.19.50.3 18921 typ host generation 0
820. a=end-of-candidates
821. a=ssrc:1072399891 cname:aQt5MUf2mcLLWmig
822. a=ssrc:1072399891 msid:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX a0
823. a=ssrc:1072399891 mslabel:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX
824. a=ssrc:1072399891 label:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaXa0
825.  
826. send 1584 bytes to udp/[172.19.51.21]:5060 at 23:53:04.661305:
827.    ------------------------------------------------------------------------
828.    SIP/2.0 200 OK
829. 2018-11-10 23:53:04.655679 [NOTICE] switch_ivr_bridge.c:736 Channel [sofia/internal/11@pbx.[anonym].net] has been answered
830.    Via: SIP/2.0/UDP 172.19.51.21:5060;branch=z9hG4bK-B89D2272;rport=5060
831.    From: <sip:11@pbx.[anonym].net>;tag=4241842629
832.    To: <sip:0108008080800@pbx.[anonym].net;user=phone>;tag=c0cZ0e0SUSKNK
833.    Call-ID: fa59464a61e75b01907f0090332616fc@5
834.    CSeq: 1286550376 INVITE
835.    Contact: <sip:0108008080800@172.19.50.3:5060;transport=udp>
836.    User-Agent: FreeSWITCH
837.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
838.    Supported: timer, path, replaces
839.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
840.    Content-Type: application/sdp
841.    Content-Disposition: session
842.    Content-Length: 760
843.    P-Asserted-Identity: "0108008080800" <sip:08008080800@pbx.[anonym].net>
844.  
845.    v=0
846.    o=FreeSWITCH 1541871459 1541871460 IN IP4 172.19.50.3
847.    s=FreeSWITCH
848.    c=IN IP4 172.19.50.3
849.    t=0 0
850.    a=msid-semantic: WMS v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX
851.    m=audio 18920 RTP/AVP 8 101 13
852.    a=rtpmap:8 PCMA/8000
853.    a=rtpmap:101 telephone-event/8000
854.    a=fmtp:101 0-16
855.    a=rtpmap:13 CN/8000
856.    a=ptime:20
857.    a=ice-ufrag:S6hEQ7A2aexCjyqk
858.    a=ice-pwd:fJfStkKFnmh9ypggmnK3kaVl
859.    a=candidate:3769281485 1 udp 659136 172.19.50.3 18920 typ host generation 0
860.    a=candidate:3769281485 2 udp 659135 172.19.50.3 18921 typ host generation 0
861.    a=end-of-candidates
862.    a=ssrc:1072399891 cname:aQt5MUf2mcLLWmig
863.    a=ssrc:1072399891 msid:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX a0
864.    a=ssrc:1072399891 mslabel:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaX
865.    a=ssrc:1072399891 label:v5PF46BjpB7TzUKGtGYbVTZ5ldOFCfaXa0
866.    ------------------------------------------------------------------------
867. 2018-11-10 23:53:04.655679 [DEBUG] switch_channel.c:3781 (sofia/internal/11@pbx.[anonym].net) Callstate Change EARLY -> ACTIVE
868. 2018-11-10 23:53:04.655679 [DEBUG] sofia.c:7291 Channel sofia/internal/11@pbx.[anonym].net entering state [completed][200]
869. send 1301 bytes to udp/[172.19.51.21]:5060 at 23:53:04.670768:
870.    ------------------------------------------------------------------------
871.    NOTIFY sip:11@172.19.51.21:5060;transport=UDP SIP/2.0
872.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bKBZSUr6QjrvKmj
873.    Max-Forwards: 70
874.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=ldmvNmA2D3ym
875.    To: <sip:11@pbx.[anonym].net>;tag=1898982082
876.    Call-ID: d5abfc275ee75b015bde0090332616fc@2
877.    CSeq: 1356459201 NOTIFY
878.    Contact: <sip:11@172.19.50.3:5060>
879.    User-Agent: FreeSWITCH
880.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
881.    Supported: timer, path, replaces
882.    Event: presence
883.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
884.    Subscription-State: active;expires=15
885.    Content-Type: application/pidf+xml
886.    Content-Length: 503
887.  
888.    <?xml version="1.0" encoding="ISO-8859-1"?>
889.    <presence xmlns='urn:ietf:params:xml:ns:pidf'
890.    xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
891.    xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
892.    xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:11@pbx.[anonym].net'>
893.     <tuple id='t6a5ed77e'>
894.      <status>
895.       <basic>open</basic>
896.      </status>
897.     </tuple>
898.     <dm:person id='p06360c4a'>
899.      <rpid:activities>
900.       <rpid:on-the-phone/>
901.      </rpid:activities>
902.      <dm:note>Talk 08008080800</dm:note>
903.     </dm:person>
904.    </presence>
905.  
906.    ------------------------------------------------------------------------
907. recv 662 bytes from udp/[172.19.51.21]:5060 at 23:53:04.671330:
908.    ------------------------------------------------------------------------
909.    ACK sip:0108008080800@172.19.50.3:5060;transport=udp SIP/2.0
910.    Proxy-Authorization: Digest username="11",realm="pbx.[anonym].net",nonce="63e024d3-63ce-40e6-96e4-609a5ba18097",response="f933176b57b576d0b597e4b3c45fcc20",uri="sip:0108008080800@pbx.[anonym].net;user=phone",qop=auth,cnonce="00039f9680560c34",nc=00000001,algorithm=MD5
911.    Via: SIP/2.0/UDP 172.19.51.21:5060;branch=z9hG4bK-B89D2273;rport
912.    From: <sip:11@pbx.[anonym].net>;tag=4241842629
913.    To: <sip:0108008080800@pbx.[anonym].net;user=phone>;tag=c0cZ0e0SUSKNK
914.    Call-ID: fa59464a61e75b01907f0090332616fc@5
915.    CSeq: 1286550376 ACK
916.    Contact: <sip:11@172.19.51.21:5060;transport=UDP>
917.    Content-Length: 0
918.    Max-Forwards: 70
919.  
920.    ------------------------------------------------------------------------
921. send 1301 bytes to udp/[172.19.51.21]:5060 at 23:53:04.671878:
922.    ------------------------------------------------------------------------
923.    NOTIFY sip:11@172.19.51.21:5060;transport=UDP SIP/2.0
924.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bKc8jmt18NN596D
925.    Max-Forwards: 70
926.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=G3MK4pPAsqMh
927.    To: <sip:11@pbx.[anonym].net>;tag=4241842626
928.    Call-ID: f22da23761e75b01897f0090332616fc@2
929.    CSeq: 1356459202 NOTIFY
930.    Contact: <sip:11@172.19.50.3:5060>
931.    User-Agent: FreeSWITCH
932.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
933.    Supported: timer, path, replaces
934.    Event: presence
935.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
936.    Subscription-State: active;expires=95
937.    Content-Type: application/pidf+xml
938.    Content-Length: 503
939.  
940.    <?xml version="1.0" encoding="ISO-8859-1"?>
941.    <presence xmlns='urn:ietf:params:xml:ns:pidf'
942.    xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
943.    xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
944.    xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:11@pbx.[anonym].net'>
945.     <tuple id='t6a5ed77e'>
946.      <status>
947.       <basic>open</basic>
948.      </status>
949.     </tuple>
950.     <dm:person id='p06360c4a'>
951.      <rpid:activities>
952.       <rpid:on-the-phone/>
953.      </rpid:activities>
954.      <dm:note>Talk 08008080800</dm:note>
955.     </dm:person>
956.    </presence>
957.  
958.    ------------------------------------------------------------------------
959. recv 353 bytes from udp/[172.19.51.21]:5060 at 23:53:04.674409:
960.    ------------------------------------------------------------------------
961.    SIP/2.0 200 OK
962.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bKBZSUr6QjrvKmj;received=172.19.50.3
963.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=ldmvNmA2D3ym
964.    To: <sip:11@pbx.[anonym].net>;tag=1898982082
965.    Call-ID: d5abfc275ee75b015bde0090332616fc@2
966.    CSeq: 1356459201 NOTIFY
967.    Content-Length: 0
968.    Server: (innovaphone IP240/12r1 sr26 [12.1257/121257/301])
969.  
970.    ------------------------------------------------------------------------
971. recv 353 bytes from udp/[172.19.51.21]:5060 at 23:53:04.677605:
972.    ------------------------------------------------------------------------
973.    SIP/2.0 200 OK
974.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bKc8jmt18NN596D;received=172.19.50.3
975.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=G3MK4pPAsqMh
976.    To: <sip:11@pbx.[anonym].net>;tag=4241842626
977.    Call-ID: f22da23761e75b01897f0090332616fc@2
978.    CSeq: 1356459202 NOTIFY
979.    Content-Length: 0
980.    Server: (innovaphone IP240/12r1 sr26 [12.1257/121257/301])
981.  
982.    ------------------------------------------------------------------------
983. 2018-11-10 23:53:04.675674 [DEBUG] sofia.c:7291 Channel sofia/internal/11@pbx.[anonym].net entering state [ready][200]
984. 2018-11-10 23:53:04.695681 [DEBUG] switch_rtp.c:7550 Correct audio ip/port confirmed.
985. recv 671 bytes from udp/[172.19.51.21]:5060 at 23:53:09.468580:
986.    ------------------------------------------------------------------------
987.    BYE sip:0108008080800@172.19.50.3:5060;transport=udp SIP/2.0
988.    Proxy-Authorization: Digest username="11",realm="pbx.[anonym].net",nonce="63e024d3-63ce-40e6-96e4-609a5ba18097",response="5b30bc0859ac48f46dcaee45584f6ac3",uri="sip:0108008080800@pbx.[anonym].net;user=phone",qop=auth,cnonce="00039f9680560c34",nc=00000002,algorithm=MD5
989.    Via: SIP/2.0/UDP 172.19.51.21:5060;branch=z9hG4bK-B89D2274;rport
990.    From: <sip:11@pbx.[anonym].net>;tag=4241842629
991.    To: <sip:0108008080800@pbx.[anonym].net;user=phone>;tag=c0cZ0e0SUSKNK
992.    Call-ID: fa59464a61e75b01907f0090332616fc@5
993.    CSeq: 1286550377 BYE
994.    Content-Length: 0
995.    Max-Forwards: 70
996.    Reason: Q.850;cause=34;text="No circuit/channel available"
997.  
998.    ------------------------------------------------------------------------
999. 2018-11-10 23:53:09.475673 [NOTICE] sofia.c:1079 Hangup sofia/internal/11@pbx.[anonym].net [CS_EXECUTE] [NORMAL_CIRCUIT_CONGESTION]
1000. send 456 bytes to udp/[172.19.51.21]:5060 at 23:53:09.484055:
1001.    ------------------------------------------------------------------------
1002. 2018-11-10 23:53:09.475673 [DEBUG] switch_ivr_bridge.c:825 sofia/internal/11@pbx.[anonym].net ending bridge by request from write function
1003.    SIP/2.0 200 OK
1004.    Via: SIP/2.0/UDP 172.19.51.21:5060;branch=z9hG4bK-B89D2274;rport=5060
1005.    From: <sip:11@pbx.[anonym].net>;tag=4241842629
1006.    To: <sip:0108008080800@pbx.[anonym].net;user=phone>;tag=c0cZ0e0SUSKNK
1007.    Call-ID: fa59464a61e75b01907f0090332616fc@5
1008.    CSeq: 1286550377 BYE
1009.    User-Agent: FreeSWITCH
1010.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
1011.    Supported: timer, path, replaces
1012.    Content-Length: 0
1013.  
1014.    ------------------------------------------------------------------------
1015. 2018-11-10 23:53:09.475673 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/external/08008080800]
1016. 2018-11-10 23:53:09.475673 [NOTICE] switch_ivr_bridge.c:1034 Hangup sofia/external/08008080800 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
1017. 2018-11-10 23:53:09.475673 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/internal/11@pbx.[anonym].net]
1018. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:653 (sofia/external/08008080800) State EXCHANGE_MEDIA going to sleep
1019. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08008080800) Running State Change CS_HANGUP (Cur 2 Tot 2)
1020. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:847 (sofia/external/08008080800) Callstate Change ACTIVE -> HANGUP
1021. 2018-11-10 23:53:09.475673 [DEBUG] switch_ivr_bridge.c:1881 sofia/external/08008080800 skip receive message [TRANSFER] (channel is hungup already)
1022. 2018-11-10 23:53:09.475673 [DEBUG] switch_ivr_bridge.c:1884 sofia/internal/11@pbx.[anonym].net skip receive message [TRANSFER] (channel is hungup already)
1023. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:849 (sofia/external/08008080800) State HANGUP
1024. 2018-11-10 23:53:09.475673 [DEBUG] mod_sofia.c:443 sofia/external/08008080800 Overriding SIP cause 480 with 200 from the other leg
1025. 2018-11-10 23:53:09.475673 [DEBUG] mod_sofia.c:449 Channel sofia/external/08008080800 hanging up, cause: NORMAL_CLEARING
1026. 2018-11-10 23:53:09.475673 [DEBUG] mod_sofia.c:502 Sending BYE to sofia/external/08008080800
1027. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:60 sofia/external/08008080800 Standard HANGUP, cause: NORMAL_CLEARING
1028. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:849 (sofia/external/08008080800) State HANGUP going to sleep
1029. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:619 (sofia/external/08008080800) State Change CS_HANGUP -> CS_REPORTING
1030. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:584 (sofia/external/08008080800) Running State Change CS_REPORTING (Cur 2 Tot 2)
1031. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_session.c:2886 sofia/internal/11@pbx.[anonym].net skip receive message [PHONE_EVENT] (channel is hungup already)
1032. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/11@pbx.[anonym].net) State EXECUTE going to sleep
1033. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@pbx.[anonym].net) Running State Change CS_HANGUP (Cur 2 Tot 2)
1034. send 931 bytes to udp/[217.0.27.32]:5060 at 23:53:09.488555:
1035.    ------------------------------------------------------------------------
1036.    BYE sip:sgc_c@217.0.27.32;transport=udp SIP/2.0
1037.    Via: SIP/2.0/UDP 172.19.50.3:5080;rport;branch=z9hG4bK1y109SjpHUZcp
1038.    Route: <sip:217.0.27.32;transport=udp;lr>
1039.    Max-Forwards: 70
1040.    From: "11" <sip:+49[anonym]206@tel.t-online.de>;tag=t2eppXypav9yK
1041.    To: <sip:08008080800@tel.t-online.de>;tag=h7g4Esbg_p65555t1541890379m568871c371372549s1_1415273537-177558755
1042.    Call-ID: 3657973f-5fde-1237-1193-000db9478a88
1043.    CSeq: 130609127 BYE
1044.    User-Agent: FreeSWITCH
1045.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
1046.    Supported: timer, path, replaces
1047.    Proxy-Authorization: Digest username="551124935083", realm="tel.t-online.de", nonce="F048CDD55761E75B00000000CFF40400", cnonce="NmqTBV/eEjeTEQANuUeKiA", algorithm=MD5, uri="sip:sgc_c@217.0.27.32;transport=udp", response="24f29709ae4baee6fcbc05ed281915e7", qop=auth, nc=00000002
1048. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:935 (sofia/external/08008080800) State REPORTING
1049.    Reason: Q.850;cause=34;text="No circuit/channel available"
1050.    Content-Length: 0
1051.  
1052.    ------------------------------------------------------------------------
1053. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:174 sofia/external/08008080800 Standard REPORTING, cause: NORMAL_CLEARING
1054. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:935 (sofia/external/08008080800) State REPORTING going to sleep
1055. 2018-11-10 23:53:09.475673 [DEBUG] switch_ivr_async.c:1413 Stop recording file /var/lib/freeswitch/recordings/pbx.[anonym].net/archive/2018/Nov/10/4ef5163f-777a-413d-8ba7-5a983d75f668.wav
1056. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:610 (sofia/external/08008080800) State Change CS_REPORTING -> CS_DESTROY
1057. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_session.c:1714 Session 2 (sofia/external/08008080800) Locked, Waiting on external entities
1058. 2018-11-10 23:53:09.475673 [NOTICE] switch_core_session.c:1732 Session 2 (sofia/external/08008080800) Ended
1059. 2018-11-10 23:53:09.475673 [NOTICE] switch_core_session.c:1736 Close Channel sofia/external/08008080800 [CS_DESTROY]
1060. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:738 (sofia/external/08008080800) Running State Change CS_DESTROY (Cur 1 Tot 2)
1061. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:748 (sofia/external/08008080800) State DESTROY
1062. 2018-11-10 23:53:09.475673 [DEBUG] mod_sofia.c:354 sofia/external/08008080800 SOFIA DESTROY
1063. 2018-11-10 23:53:09.475673 [DEBUG] switch_ivr_async.c:1488 Channel is hung up
1064. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:181 sofia/external/08008080800 Standard DESTROY
1065. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:748 (sofia/external/08008080800) State DESTROY going to sleep
1066. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_media_bug.c:1276 Removing BUG from sofia/internal/11@pbx.[anonym].net
1067. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:847 (sofia/internal/11@pbx.[anonym].net) Callstate Change ACTIVE -> HANGUP
1068. 2018-11-10 23:53:09.475673 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/11@pbx.[anonym].net) State HANGUP
1069. 2018-11-10 23:53:09.475673 [DEBUG] mod_sofia.c:449 Channel sofia/internal/11@pbx.[anonym].net hanging up, cause: NORMAL_CIRCUIT_CONGESTION
1070. 2018-11-10 23:53:09.495699 [DEBUG] switch_core_state_machine.c:60 sofia/internal/11@pbx.[anonym].net Standard HANGUP, cause: NORMAL_CIRCUIT_CONGESTION
1071. 2018-11-10 23:53:09.495699 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/11@pbx.[anonym].net) State HANGUP going to sleep
1072. 2018-11-10 23:53:09.495699 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/11@pbx.[anonym].net) State Change CS_HANGUP -> CS_REPORTING
1073. 2018-11-10 23:53:09.495699 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/11@pbx.[anonym].net) Running State Change CS_REPORTING (Cur 1 Tot 2)
1074. 2018-11-10 23:53:09.495699 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/11@pbx.[anonym].net) State REPORTING
1075. send 1228 bytes to udp/[172.19.51.21]:5060 at 23:53:09.506545:
1076.    ------------------------------------------------------------------------
1077.    NOTIFY sip:11@172.19.51.21:5060;transport=UDP SIP/2.0
1078.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bKDHcDvvSSje0SS
1079.    Max-Forwards: 70
1080.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=ldmvNmA2D3ym
1081.    To: <sip:11@pbx.[anonym].net>;tag=1898982082
1082.    Call-ID: d5abfc275ee75b015bde0090332616fc@2
1083.    CSeq: 1356459451 NOTIFY
1084.    Contact: <sip:11@172.19.50.3:5060>
1085.    User-Agent: FreeSWITCH
1086.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
1087.    Supported: timer, path, replaces
1088.    Event: presence
1089.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
1090.    Subscription-State: active;expires=10
1091.    Content-Type: application/pidf+xml
1092.    Content-Length: 430
1093.  
1094.    <?xml version="1.0" encoding="ISO-8859-1"?>
1095.    <presence xmlns='urn:ietf:params:xml:ns:pidf'
1096.    xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
1097.    xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
1098.    xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:11@pbx.[anonym].net'>
1099.     <tuple id='t6a5ed77e'>
1100.      <status>
1101.       <basic>open</basic>
1102.      </status>
1103.     </tuple>
1104.     <dm:person id='p06360c4a'>
1105.      <dm:note>Available</dm:note>
1106.     </dm:person>
1107.    </presence>
1108.  
1109.    ------------------------------------------------------------------------
1110. send 1228 bytes to udp/[172.19.51.21]:5060 at 23:53:09.507535:
1111.    ------------------------------------------------------------------------
1112.    NOTIFY sip:11@172.19.51.21:5060;transport=UDP SIP/2.0
1113.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bKet55XQaXFQpcN
1114.    Max-Forwards: 70
1115.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=G3MK4pPAsqMh
1116.    To: <sip:11@pbx.[anonym].net>;tag=4241842626
1117.    Call-ID: f22da23761e75b01897f0090332616fc@2
1118.    CSeq: 1356459452 NOTIFY
1119.    Contact: <sip:11@172.19.50.3:5060>
1120.    User-Agent: FreeSWITCH
1121.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
1122.    Supported: timer, path, replaces
1123.    Event: presence
1124.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
1125.    Subscription-State: active;expires=90
1126.    Content-Type: application/pidf+xml
1127.    Content-Length: 430
1128.  
1129.    <?xml version="1.0" encoding="ISO-8859-1"?>
1130.    <presence xmlns='urn:ietf:params:xml:ns:pidf'
1131.    xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
1132.    xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
1133.    xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:11@pbx.[anonym].net'>
1134.     <tuple id='t6a5ed77e'>
1135.      <status>
1136.       <basic>open</basic>
1137.      </status>
1138.     </tuple>
1139.     <dm:person id='p06360c4a'>
1140.      <dm:note>Available</dm:note>
1141.     </dm:person>
1142.    </presence>
1143.  
1144.    ------------------------------------------------------------------------
1145. recv 353 bytes from udp/[172.19.51.21]:5060 at 23:53:09.510465:
1146.    ------------------------------------------------------------------------
1147.    SIP/2.0 200 OK
1148.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bKDHcDvvSSje0SS;received=172.19.50.3
1149.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=ldmvNmA2D3ym
1150.    To: <sip:11@pbx.[anonym].net>;tag=1898982082
1151.    Call-ID: d5abfc275ee75b015bde0090332616fc@2
1152.    CSeq: 1356459451 NOTIFY
1153.    Content-Length: 0
1154.    Server: (innovaphone IP240/12r1 sr26 [12.1257/121257/301])
1155.  
1156.    ------------------------------------------------------------------------
1157. recv 353 bytes from udp/[172.19.51.21]:5060 at 23:53:09.513631:
1158.    ------------------------------------------------------------------------
1159.    SIP/2.0 200 OK
1160.    Via: SIP/2.0/UDP 172.19.50.3;rport;branch=z9hG4bKet55XQaXFQpcN;received=172.19.50.3
1161.    From: <sip:11@pbx.[anonym].net;user=phone>;tag=G3MK4pPAsqMh
1162.    To: <sip:11@pbx.[anonym].net>;tag=4241842626
1163.    Call-ID: f22da23761e75b01897f0090332616fc@2
1164.    CSeq: 1356459452 NOTIFY
1165.    Content-Length: 0
1166.    Server: (innovaphone IP240/12r1 sr26 [12.1257/121257/301])
1167.  
1168.    ------------------------------------------------------------------------
1169. recv 475 bytes from udp/[217.0.27.32]:5060 at 23:53:09.555735:
1170.    ------------------------------------------------------------------------
1171.    SIP/2.0 200 OK
1172.    Via: SIP/2.0/UDP 172.19.50.3:5080;received=172.19.50.3;rport=5080;branch=z9hG4bK1y109SjpHUZcp
1173.    To: <sip:08008080800@tel.t-online.de>;tag=h7g4Esbg_p65555t1541890379m568871c371372549s1_1415273537-177558755
1174.    From: "11" <sip:+49[anonym]206@tel.t-online.de>;tag=t2eppXypav9yK
1175.    Call-ID: 3657973f-5fde-1237-1193-000db9478a88
1176.    CSeq: 130609127 BYE
1177.    Content-Length: 0
1178.   Allow: REGISTER, REFER, NOTIFY, SUBSCRIBE, INFO, PRACK, UPDATE, INVITE, ACK, OPTIONS, CANCEL, BYE
1179.  
1180.    ------------------------------------------------------------------------
1181. 2018-11-10 23:53:09.715693 [DEBUG] switch_core_state_machine.c:174 sofia/internal/11@pbx.[anonym].net Standard REPORTING, cause: NORMAL_CIRCUIT_CONGESTION
1182. 2018-11-10 23:53:09.715693 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/11@pbx.[anonym].net) State REPORTING going to sleep
1183. 2018-11-10 23:53:09.715693 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/11@pbx.[anonym].net) State Change CS_REPORTING -> CS_DESTROY
1184. 2018-11-10 23:53:09.715693 [DEBUG] switch_core_session.c:1714 Session 1 (sofia/internal/11@pbx.[anonym].net) Locked, Waiting on external entities
1185. 2018-11-10 23:53:09.715693 [NOTICE] switch_core_session.c:1732 Session 1 (sofia/internal/11@pbx.[anonym].net) Ended
1186. 2018-11-10 23:53:09.715693 [NOTICE] switch_core_session.c:1736 Close Channel sofia/internal/11@pbx.[anonym].net [CS_DESTROY]
1187. 2018-11-10 23:53:09.715693 [DEBUG] switch_core_state_machine.c:738 (sofia/internal/11@pbx.[anonym].net) Running State Change CS_DESTROY (Cur 0 Tot 2)
1188. 2018-11-10 23:53:09.715693 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/11@pbx.[anonym].net) State DESTROY
1189. 2018-11-10 23:53:09.715693 [DEBUG] mod_sofia.c:354 sofia/internal/11@pbx.[anonym].net SOFIA DESTROY
1190. 2018-11-10 23:53:09.715693 [DEBUG] switch_core_state_machine.c:181 sofia/internal/11@pbx.[anonym].net Standard DESTROY
1191. 2018-11-10 23:53:09.715693 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/11@pbx.[anonym].net) State DESTROY going to sleep
1192. recv 763 bytes from udp/[172.19.50.4]:3861 at 23:53:28.746907:
1193.    ------------------------------------------------------------------------
1194.    REGISTER sip:pbx.[anonym].net SIP/2.0
1195.    Authorization: Digest username="9590206",realm="pbx.[anonym].net",nonce="d9fb4777-4364-4a78-b513-5925e62367b5",response="09cc45b9fc7d30b531b18804e1c84e5a",uri="sip:pbx.[anonym].net",qop=auth,cnonce="719b57f454db5b017ede009033060682",nc=00000002,algorithm=MD5
1196.    Via: SIP/2.0/UDP 172.19.50.4:3861;branch=z9hG4bK-03B4322B;rport
1197.    From: <sip:9590206@pbx.[anonym].net>;tag=2770963674
1198.    To: <sip:9590206@pbx.[anonym].net>
1199.    Call-ID: c7e2bd8b47e55b014639009033060682
1200.    CSeq: 2568 REGISTER
1201.    Contact: <sip:9590206@172.19.50.4:3861;transport=UDP>;expires=120
1202.    Accept: innovaphone/data
1203.    Content-Length: 0
1204.    Expires: 120
1205.    Max-Forwards: 70
1206.    User-Agent: (innovaphone IP800/11r2 sr15 [11.3587/113587/106])
1207.    Allow-Events: reg,dialog,message-summary,presence
1208.  
1209.    ------------------------------------------------------------------------
1210. send 544 bytes to udp/[172.19.50.4]:3861 at 23:53:28.788886:
1211.    ------------------------------------------------------------------------
1212.    SIP/2.0 200 OK
1213.    Via: SIP/2.0/UDP 172.19.50.4:3861;branch=z9hG4bK-03B4322B;rport=3861
1214.    From: <sip:9590206@pbx.[anonym].net>;tag=2770963674
1215.    To: <sip:9590206@pbx.[anonym].net>;tag=D95Q29gXr297e
1216.    Call-ID: c7e2bd8b47e55b014639009033060682
1217.    CSeq: 2568 REGISTER
1218.    Contact: <sip:9590206@172.19.50.4:3861;transport=UDP>;expires=120
1219.    Date: Sat, 10 Nov 2018 22:53:28 GMT
1220.    User-Agent: FreeSWITCH
1221.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
1222.    Supported: timer, path, replaces
1223.    Content-Length: 0
1224.  
1225.    ------------------------------------------------------------------------
1226.