FreeSWITCH Pastebin

no voice with innovaphone

From Daniel, 5 Years ago, written in FreeSWITCH.
- view diff
URL https://pastebin.freeswitch.org/view/db088714
Embed
Download Paste or View Raw
  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.  

Reply to "no voice with innovaphone"