FreeSWITCH Pastebin

zRTP + OPUS issue

From Andrea Mazzeo, 6 Years ago, written in FreeSWITCH.
- view diff
URL https://pastebin.freeswitch.org/view/639adfe9
Embed
Download Paste or View Raw
  1.    ------------------------------------------------------------------------
  2. recv 1435 bytes from tls/[31.102.111.132]:44832 at 11:18:49.558706:
  3.    ------------------------------------------------------------------------
  4.    INVITE sip:213@pbx-186.smallunix.net SIP/2.0
  5.    Via: SIP/2.0/TLS 192.168.128.158:51018;branch=z9hG4bK8boxBH49PYetiBQK;rport
  6.    Contact: <sip:207@192.168.128.158:51018;transport=tls>
  7.    Max-Forwards: 70
  8.    From: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  9.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY
  10.    Supported: replaces, path
  11.    To: <sip:213@pbx-186.smallunix.net>
  12.    Content-Type: application/sdp
  13.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  14.    CSeq: 1 INVITE
  15.    User-Agent: Acrobits Softphone Business/3.8.2
  16.    Content-Length: 860
  17.  
  18.    v=0
  19.    o=- 7334585884 37217 IN IP4 172.26.170.170
  20.    s=hdabkzi
  21.    c=IN IP4 192.168.128.158
  22.    t=0 0
  23.    m=audio 59416 RTP/SAVP 103 101
  24.    a=rtpmap:101 telephone-event/8000
  25.    a=rtpmap:103 opus/48000/2
  26.    a=fmtp:101 0-15
  27.    a=fmtp:103 maxplaybackrate=16000;maxaveragebitrate=24000;useinbandfec=1;usedtx=1
  28.    a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:yYHBMOGW8Ltl9qsl0E7Rx+lAaUDSBRAN60y2I8tK
  29.    a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:2AAmgPkHkRKzBKzgbZ1mOKsrKyuFePpPoqmG98JC
  30.    a=ptime:20
  31.    a=zrtp-hash:1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  32.    a=sendrecv
  33.    m=audio 59416 RTP/AVP 103 101
  34.    a=rtpmap:101 telephone-event/8000
  35.    a=rtpmap:103 opus/48000/2
  36.    a=fmtp:101 0-15
  37.    a=fmtp:103 maxplaybackrate=16000;maxaveragebitrate=24000;useinbandfec=1;usedtx=1
  38.    a=ptime:20
  39.    a=zrtp-hash:1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  40.    a=sendrecv
  41.    ------------------------------------------------------------------------
  42. 2018-09-20 11:18:49.558485 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/207@pbx-186.smallunix.net [265825de-d70a-4217-909d-341517d2425e]
  43. 2018-09-20 11:18:49.558485 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/207@pbx-186.smallunix.net) Running State Change CS_NEW (Cur 1 Tot 243)
  44. 2018-09-20 11:18:49.558485 [DEBUG] sofia.c:10080 sofia/internal/207@pbx-186.smallunix.net receiving invite from 31.102.111.132:44832 version: 1.8.1 -2-4f54cff 64bit
  45. 2018-09-20 11:18:49.558485 [DEBUG] switch_core_media.c:495 Found audio zrtp-hash; setting r_sdp_audio_zrtp_hash=1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  46. 2018-09-20 11:18:49.558485 [DEBUG] sofia.c:10251 IP 31.102.111.132 Rejected by acl "domains". Falling back to Digest auth.
  47. 2018-09-20 11:18:49.558485 [WARNING] sofia_reg.c:1793 SIP auth challenge (INVITE) on sofia profile 'internal' for [213@pbx-186.smallunix.net] from ip 31.102.111.132
  48. 2018-09-20 11:18:49.558485 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/207@pbx-186.smallunix.net) State NEW
  49. send 877 bytes to tls/[31.102.111.132]:44832 at 11:18:49.561003:
  50.    ------------------------------------------------------------------------
  51.    SIP/2.0 407 Proxy Authentication Required
  52.    Via: SIP/2.0/TLS 192.168.128.158:51018;branch=z9hG4bK8boxBH49PYetiBQK;rport=44832;received=31.102.111.132
  53.    From: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  54.    To: <sip:213@pbx-186.smallunix.net>;tag=KmFSaS5j48USp
  55.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  56.    CSeq: 1 INVITE
  57.    User-Agent: SWO-PBX-1.0
  58.    Accept: application/sdp
  59.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  60.    Supported: timer, path, replaces
  61.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  62.    Proxy-Authenticate: Digest realm="pbx-186.smallunix.net", nonce="a47174b4-0e85-44e5-a9c3-6e964cd7231a", algorithm=MD5, qop="auth"
  63.    Content-Length: 0
  64.  
  65.    ------------------------------------------------------------------------
  66. 2018-09-20 11:18:49.558485 [DEBUG] sofia.c:2413 detaching session 265825de-d70a-4217-909d-341517d2425e
  67. recv 414 bytes from tls/[31.102.111.132]:44832 at 11:18:49.625037:
  68.    ------------------------------------------------------------------------
  69.    ACK sip:213@pbx-186.smallunix.net SIP/2.0
  70.    Via: SIP/2.0/TLS 192.168.128.158:51018;branch=z9hG4bK8boxBH49PYetiBQK;rport
  71.    Max-Forwards: 70
  72.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  73.    From: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  74.    To: <sip:213@pbx-186.smallunix.net>;tag=KmFSaS5j48USp
  75.    CSeq: 1 ACK
  76.    User-Agent: Acrobits Softphone Business/3.8.2
  77.    Content-Length: 0
  78.  
  79.    ------------------------------------------------------------------------
  80. recv 1701 bytes from tls/[31.102.111.132]:44832 at 11:18:49.625210:
  81.    ------------------------------------------------------------------------
  82.    INVITE sip:213@pbx-186.smallunix.net SIP/2.0
  83.    Via: SIP/2.0/TLS 192.168.128.158:51018;branch=z9hG4bKrXUOdwO6LSgwFeG6;rport
  84.    Contact: <sip:207@192.168.128.158:51018;transport=tls>
  85.    Max-Forwards: 70
  86.    From: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  87.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY
  88.    Supported: replaces, path
  89.    To: <sip:213@pbx-186.smallunix.net>
  90.    Content-Type: application/sdp
  91.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  92.    CSeq: 2 INVITE
  93.    Proxy-Authorization: Digest username="207",realm="pbx-186.smallunix.net",algorithm=MD5,uri="sip:213@pbx-186.smallunix.net",nonce="a47174b4-0e85-44e5-a9c3-6e964cd7231a",qop=auth,cnonce="W6Nl+bkl4YHe20K4yUEVcpgz",nc=00000001,response="8440ad0640ae1ed8a1d26977d71a589b"
  94.    User-Agent: Acrobits Softphone Business/3.8.2
  95.    Content-Length: 860
  96.  
  97.    v=0
  98.    o=- 7334585884 37217 IN IP4 172.26.170.170
  99.    s=hdabkzi
  100.    c=IN IP4 192.168.128.158
  101.    t=0 0
  102.    m=audio 59416 RTP/SAVP 103 101
  103.    a=rtpmap:101 telephone-event/8000
  104.    a=rtpmap:103 opus/48000/2
  105.    a=fmtp:101 0-15
  106.    a=fmtp:103 maxplaybackrate=16000;maxaveragebitrate=24000;useinbandfec=1;usedtx=1
  107.    a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:yYHBMOGW8Ltl9qsl0E7Rx+lAaUDSBRAN60y2I8tK
  108.    a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:2AAmgPkHkRKzBKzgbZ1mOKsrKyuFePpPoqmG98JC
  109.    a=ptime:20
  110.    a=zrtp-hash:1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  111.    a=sendrecv
  112.    m=audio 59416 RTP/AVP 103 101
  113.    a=rtpmap:101 telephone-event/8000
  114.    a=rtpmap:103 opus/48000/2
  115.    a=fmtp:101 0-15
  116.    a=fmtp:103 maxplaybackrate=16000;maxaveragebitrate=24000;useinbandfec=1;usedtx=1
  117.    a=ptime:20
  118.    a=zrtp-hash:1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  119.    a=sendrecv
  120.    ------------------------------------------------------------------------
  121. 2018-09-20 11:18:49.618505 [DEBUG] sofia.c:2522 Re-attaching to session 265825de-d70a-4217-909d-341517d2425e
  122. 2018-09-20 11:18:49.638482 [DEBUG] sofia.c:10080 sofia/internal/207@pbx-186.smallunix.net receiving invite from 31.102.111.132:44832 version: 1.8.1 -2-4f54cff 64bit
  123. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:495 Found audio zrtp-hash; setting r_sdp_audio_zrtp_hash=1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  124. 2018-09-20 11:18:49.638482 [DEBUG] sofia.c:10251 IP 31.102.111.132 Rejected by acl "domains". Falling back to Digest auth.
  125. 2018-09-20 11:18:49.638482 [DEBUG] sofia.c:11388 Setting NAT mode based on nat.auto
  126. 2018-09-20 11:18:49.638482 [DEBUG] sofia.c:7291 Channel sofia/internal/207@pbx-186.smallunix.net entering state [received][100]
  127. 2018-09-20 11:18:49.638482 [DEBUG] sofia.c:7301 Remote SDP:
  128. v=0
  129. o=- 7334585884 37217 IN IP4 172.26.170.170
  130. s=hdabkzi
  131. c=IN IP4 192.168.128.158
  132. t=0 0
  133. m=audio 59416 RTP/SAVP 103 101
  134. a=rtpmap:103 opus/48000/2
  135. a=fmtp:103 maxplaybackrate=16000;maxaveragebitrate=24000;useinbandfec=1;usedtx=1
  136. a=rtpmap:101 telephone-event/8000
  137. a=fmtp:101 0-15
  138. a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:yYHBMOGW8Ltl9qsl0E7Rx+lAaUDSBRAN60y2I8tK
  139. a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:2AAmgPkHkRKzBKzgbZ1mOKsrKyuFePpPoqmG98JC
  140. a=ptime:20
  141. a=zrtp-hash:1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  142. m=audio 59416 RTP/AVP 103 101
  143. a=rtpmap:103 opus/48000/2
  144. a=fmtp:103 maxplaybackrate=16000;maxaveragebitrate=24000;useinbandfec=1;usedtx=1
  145. a=rtpmap:101 telephone-event/8000
  146. a=fmtp:101 0-15
  147. a=ptime:20
  148. a=zrtp-hash:1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  149.  
  150. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:495 Found audio zrtp-hash; setting r_sdp_audio_zrtp_hash=1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  151. 2018-09-20 11:18:49.638482 [DEBUG] sofia.c:7695 (sofia/internal/207@pbx-186.smallunix.net) State Change CS_NEW -> CS_INIT
  152. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/207@pbx-186.smallunix.net) Running State Change CS_INIT (Cur 1 Tot 243)
  153. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/207@pbx-186.smallunix.net) State INIT
  154. 2018-09-20 11:18:49.638482 [DEBUG] mod_sofia.c:93 sofia/internal/207@pbx-186.smallunix.net SOFIA INIT
  155. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:40 sofia/internal/207@pbx-186.smallunix.net Standard INIT
  156. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/207@pbx-186.smallunix.net) State Change CS_INIT -> CS_ROUTING
  157. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/207@pbx-186.smallunix.net) State INIT going to sleep
  158. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/207@pbx-186.smallunix.net) Running State Change CS_ROUTING (Cur 1 Tot 243)
  159. 2018-09-20 11:18:49.638482 [DEBUG] switch_channel.c:2249 (sofia/internal/207@pbx-186.smallunix.net) Callstate Change DOWN -> RINGING
  160. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/207@pbx-186.smallunix.net) State ROUTING
  161. 2018-09-20 11:18:49.638482 [DEBUG] mod_sofia.c:154 sofia/internal/207@pbx-186.smallunix.net SOFIA ROUTING
  162. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:236 sofia/internal/207@pbx-186.smallunix.net Standard ROUTING
  163. 2018-09-20 11:18:49.638482 [INFO] mod_dialplan_xml.c:637 Processing Andrea Mazzeo <207>->213 in context pbx-186.smallunix.net
  164. send 366 bytes to tls/[31.102.111.132]:44832 at 11:18:49.644397:
  165.    ------------------------------------------------------------------------
  166.    SIP/2.0 100 Trying
  167.    Via: SIP/2.0/TLS 192.168.128.158:51018;branch=z9hG4bKrXUOdwO6LSgwFeG6;rport=44832;received=31.102.111.132
  168.    From: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  169.    To: <sip:213@pbx-186.smallunix.net>
  170.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  171.    CSeq: 2 INVITE
  172.    User-Agent: SWO-PBX-1.0
  173.    Content-Length: 0
  174.  
  175.    ------------------------------------------------------------------------
  176. 2018-09-20 11:18:49.638482 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/213@192.168.129.176:50560 [7018033a-46f6-4613-bb20-e851e7a944ea]
  177. 2018-09-20 11:18:49.638482 [DEBUG] mod_sofia.c:5028 (sofia/internal/213@192.168.129.176:50560) State Change CS_NEW -> CS_INIT
  178. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:371 Passing a-leg remote zrtp-hash (audio) to b-leg
  179. 2018-09-20 11:18:49.638482 [DEBUG] mod_sofia.c:5098 [zrtp_passthru] Setting a-leg inherit_codec=true
  180. 2018-09-20 11:18:49.638482 [DEBUG] mod_sofia.c:5101 [zrtp_passthru] Setting b-leg absolute_codec_string='mod_opus.opus@48000h@20i@2c,mod_opus.opus@48000h@20i@2c'
  181. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/213@192.168.129.176:50560) Running State Change CS_INIT (Cur 2 Tot 244)
  182. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/213@192.168.129.176:50560) State INIT
  183. 2018-09-20 11:18:49.638482 [DEBUG] mod_sofia.c:93 sofia/internal/213@192.168.129.176:50560 SOFIA INIT
  184. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local audio crypto Key [1 AEAD_AES_256_GCM_8 inline:JFtFyIfqr9s0CLLhMzZM2DBij4W8ZMBwCilg3OJjLmgbjgJ8m6MTtO7ZXu0]
  185. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local video crypto Key [1 AEAD_AES_256_GCM_8 inline:Rbu9DV5+/pYb4d7ivJG4ogq1kUDv/5TBJUGpY4hM50f/phGioPye91c5yFY]
  186. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local text crypto Key [1 AEAD_AES_256_GCM_8 inline:22oUKP3r0QHQMzes0tdAJQg6jF2BizX25Hv3bRwjkDD2+tCtJ+oShfHQArA]
  187. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local audio crypto Key [2 AEAD_AES_128_GCM_8 inline:euTvSAIt4JHpKh9T3O4DpkvwCazQ5SMS8KP+YA]
  188. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local video crypto Key [2 AEAD_AES_128_GCM_8 inline:Fr4hI3aZ+ky9R7A3M+qrYpjS/vEuZ55ug7b5LA]
  189. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local text crypto Key [2 AEAD_AES_128_GCM_8 inline:8jlaH6U6DYVAgeYlX+mxDyUglONXRNuetodKTA]
  190. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local audio crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:WhULTfxLspM+mMa1h2hvrZpfCe1rz6EXRhPPx0JPXUTPNaPfnMHaXcehHKWC7g]
  191. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local video crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:j/UIv0xFR2RZqlB4JTGwl4A0yba88CZBoxui9cMmrobDoju15BRUMafiQtT/WA]
  192. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local text crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:WRJ19r8HBwnVemruwVB/i4Io5w5kghRClw7HlA5sQfMde2ooBYtBQLdW6rLabw]
  193. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local audio crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:DeT7BKdqueIdG4nGrNeWiGWUaVYguyEcm4L++6fGyKzixTLX6jo]
  194. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local video crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:M0h8DHq3YaCW3QMLfliR0DzftCsw6vd3TEhJ9QxABV/UZUk2tQw]
  195. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local text crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:8de4Q3fyynj80xWPVrbPaNPNlsex0YDZZCINcZJTKr+FfYCz5W8]
  196. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local audio crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:aVXcsQjwL27rlbVRYc+BvTFoZ6e5hpdtWGx3E4ro]
  197. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local video crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:oG85AwdGp6JVzNK5ylSRmwfwL4MeBeSPDW6ju44s]
  198. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local text crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:jZWe5iW4y1iXAFZg6ary4FUyECG774bBs1sd0k7K]
  199. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local audio crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:X3wZWjOAR8vgVriREgZTWijl5HaDXkF5XDRauP66d8FdY4u3K2kW/NKTpXEg1g]
  200. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local video crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:oTFDyJ01aTRuJXNZhuxXLKaXcFGkmThl83VybKWNkatOCkiJLeIB2bjXysWLYQ]
  201. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local text crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:xRYeprP5H5hf4gdaxP3Q27kijHpesi7LAr7BmPU5wKlIBrob1mZm6oT9J2mY0Q]
  202. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local audio crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:nMOsOBO6y8zdb9akWjbfP4E20BVcsBSxF6mqd1ezRp3oAzqkC14]
  203. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local video crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:ESPqiePeGp3gWQYenzF5KE2xOjQJPXTMGquAAWp/f+6UlEQ3DTQ]
  204. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local text crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:EHZFIjh/vaUbjuEONSeBl0dYSJSrRpeYHv3d/2VyXJi36sUSsaA]
  205. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local audio crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:hsr/O+i9JCXiZN4rM3zXLt1nYxW4MGQqmkpwoxBx]
  206. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local video crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:lxn74blOHNKJDAEC2/YJUP3mK3+WIBrHdpanBywB]
  207. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local text crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:v2W5TbZtfFLOa4IkRJEnq3N2wf3yoLHkhEJMo9hy]
  208. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local audio crypto Key [9 AES_CM_128_NULL_AUTH inline:2c+6dPgCx1iwloN9j9oBSgo9/o+4pFKQO6zGMRg4]
  209. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local video crypto Key [9 AES_CM_128_NULL_AUTH inline:mXF8x9taBY1HldtBHCfeSGnX6mYxS0oPJxV0Tovg]
  210. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:1207 Set Local text crypto Key [9 AES_CM_128_NULL_AUTH inline:1I2chO7YGs2LENlIRLXSBfEgiVyC9fo3J2c2OuDZ]
  211. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_media.c:9886 Adding audio a=zrtp-hash:1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  212. 2018-09-20 11:18:49.638482 [DEBUG] sofia_glue.c:1268 sip:213@49.172.161.250:50560;rinstance=292D7641;transport=tls Setting proxy route to sofia/internal/213@192.168.129.176:50560
  213. 2018-09-20 11:18:49.638482 [DEBUG] sofia_glue.c:1299 sofia/internal/213@192.168.129.176:50560 sending invite version: 1.8.1 -2-4f54cff 64bit
  214. Local SDP:
  215. v=0
  216. o=FreeSWITCH 1537413935 1537413936 IN IP4 31.102.111.134
  217. s=FreeSWITCH
  218. c=IN IP4 31.102.111.134
  219. t=0 0
  220. m=audio 21194 RTP/SAVP 102 101 13
  221. a=rtpmap:102 opus/48000/2
  222. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1
  223. a=rtpmap:101 telephone-event/48000
  224. a=fmtp:101 0-16
  225. a=crypto:1 AEAD_AES_256_GCM_8 inline:JFtFyIfqr9s0CLLhMzZM2DBij4W8ZMBwCilg3OJjLmgbjgJ8m6MTtO7ZXu0
  226. a=crypto:2 AEAD_AES_128_GCM_8 inline:euTvSAIt4JHpKh9T3O4DpkvwCazQ5SMS8KP+YA
  227. a=crypto:3 AES_CM_256_HMAC_SHA1_80 inline:WhULTfxLspM+mMa1h2hvrZpfCe1rz6EXRhPPx0JPXUTPNaPfnMHaXcehHKWC7g
  228. a=crypto:4 AES_CM_192_HMAC_SHA1_80 inline:DeT7BKdqueIdG4nGrNeWiGWUaVYguyEcm4L++6fGyKzixTLX6jo
  229. a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:aVXcsQjwL27rlbVRYc+BvTFoZ6e5hpdtWGx3E4ro
  230. a=crypto:6 AES_CM_256_HMAC_SHA1_32 inline:X3wZWjOAR8vgVriREgZTWijl5HaDXkF5XDRauP66d8FdY4u3K2kW/NKTpXEg1g
  231. a=crypto:7 AES_CM_192_HMAC_SHA1_32 inline:nMOsOBO6y8zdb9akWjbfP4E20BVcsBSxF6mqd1ezRp3oAzqkC14
  232. a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:hsr/O+i9JCXiZN4rM3zXLt1nYxW4MGQqmkpwoxBx
  233. a=crypto:9 AES_CM_128_NULL_AUTH inline:2c+6dPgCx1iwloN9j9oBSgo9/o+4pFKQO6zGMRg4
  234. a=rtpmap:13 CN/48000
  235. a=ptime:20
  236. a=zrtp-hash:1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  237. a=sendrecv
  238.  
  239. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:40 sofia/internal/213@192.168.129.176:50560 Standard INIT
  240. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/213@192.168.129.176:50560) State Change CS_INIT -> CS_ROUTING
  241. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/213@192.168.129.176:50560) State INIT going to sleep
  242. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/213@192.168.129.176:50560) Running State Change CS_ROUTING (Cur 2 Tot 244)
  243. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/213@192.168.129.176:50560) State ROUTING
  244. 2018-09-20 11:18:49.638482 [DEBUG] mod_sofia.c:154 sofia/internal/213@192.168.129.176:50560 SOFIA ROUTING
  245. 2018-09-20 11:18:49.638482 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/213@192.168.129.176:50560) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  246. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/213@192.168.129.176:50560) State ROUTING going to sleep
  247.  
  248. send 2339 bytes to tls/[49.172.161.250]:50560 at 11:18:49.655563:
  249.    ------------------------------------------------------------------------
  250.    INVITE sip:213@192.168.129.176:50560;rinstance=292D7641;transport=tls SIP/2.0
  251.    Via: SIP/2.0/TLS 31.102.111.134;branch=z9hG4bK5XQ58Qg22jNjr
  252.    Route: <sip:213@49.172.161.250:50560>;rinstance=292D7641;transport=tls
  253.    Max-Forwards: 69
  254.    From: "Andrea Mazzeo" <sip:207@31.102.111.134>;tag=N61aeF7Syt8yD
  255.    To: <sip:213@192.168.129.176:50560;rinstance=292D7641;transport=tls>
  256.    Call-ID: 068e6451-3759-1237-c4ba-000c2919b6af
  257.    CSeq: 128381500 INVITE
  258.    Contact: <sip:mod_sofia@31.102.111.134:5061;transport=tls>
  259.    User-Agent: SWO-PBX-1.0
  260.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  261.    Supported: timer, path, replaces
  262.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  263.    Content-Type: application/sdp
  264.    Content-Disposition: session
  265.    Content-Length: 1286
  266.    X-FS-Support: update_display,send_info
  267.    Remote-Party-ID: "Andrea Mazzeo" <sip:207@31.102.111.134>;party=calling;screen=yes;privacy=off
  268.  
  269.    v=0
  270.    o=FreeSWITCH 1537413935 1537413936 IN IP4 31.102.111.134
  271.    s=FreeSWITCH
  272.    c=IN IP4 31.102.111.134
  273.    t=0 0
  274.    m=audio 21194 RTP/SAVP 102 101 13
  275.    a=rtpmap:102 opus/48000/2
  276.    a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1
  277.    a=rtpmap:101 telephone-event/48000
  278.    a=fmtp:101 0-16
  279.    a=rtpmap:13 CN/48000
  280.    a=crypto:1 AEAD_AES_256_GCM_8 inline:JFtFyIfqr9s0CLLhMzZM2DBij4W8ZMBwCilg3OJjLmgbjgJ8m6MTtO7ZXu0
  281.    a=crypto:2 AEAD_AES_128_GCM_8 inline:euTvSAIt4JHpKh9T3O4DpkvwCazQ5SMS8KP+YA
  282.    a=crypto:3 AES_CM_256_HMAC_SHA1_80 inline:WhULTfxLspM+mMa1h2hvrZpfCe1rz6EXRhPPx0JPXUTPNaPfnMHaXcehHKWC7g
  283.    a=crypto:4 AES_CM_192_HMAC_SHA1_80 inline:DeT7BKdqueIdG4nGrNeWiGWUaVYguyEcm4L++6fGyKzixTLX6jo
  284.    a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:aVXcsQjwL27rlbVRYc+BvTFoZ6e5hpdtWGx3E4ro
  285.    a=crypto:6 AES_CM_256_HMAC_SHA1_32 inline:X3wZWjOAR8vgVriREgZTWijl5HaDXkF5XDRauP66d8FdY4u3K2kW/NKTpXEg1g
  286.    a=crypto:7 AES_CM_192_HMAC_SHA1_32 inline:nMOsOBO6y8zdb9akWjbfP4E20BVcsBSxF6mqd1ezRp3oAzqkC14
  287.    a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:hsr/O+i9JCXiZN4rM3zXLt1nYxW4MGQqmkpwoxBx
  288.    a=crypto:9 AES_CM_128_NULL_AUTH inline:2c+6dPgCx1iwloN9j9oBSgo9/o+4pFKQO6zGMRg4
  289.    a=ptime:20
  290.    a=zrtp-hash:1.10 1C4E69454FCD1BB7AE3439803C631BEDF11215DDF0BDC2351399921DECF8EEE1
  291.    ------------------------------------------------------------------------
  292. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/213@192.168.129.176:50560) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 244)
  293. 2018-09-20 11:18:49.638482 [DEBUG] sofia.c:7291 Channel sofia/internal/213@192.168.129.176:50560 entering state [calling][0]
  294. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/213@192.168.129.176:50560) State CONSUME_MEDIA
  295. 2018-09-20 11:18:49.638482 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/213@192.168.129.176:50560) State CONSUME_MEDIA going to sleep
  296. recv 354 bytes from tls/[49.172.161.250]:50560 at 11:18:49.812287:
  297.    ------------------------------------------------------------------------
  298.    SIP/2.0 100 Trying
  299.    Via: SIP/2.0/TLS 31.102.111.134;branch=z9hG4bK5XQ58Qg22jNjr
  300.    From: "Andrea Mazzeo" <sip:207@31.102.111.134>;tag=N61aeF7Syt8yD
  301.    Call-ID: 068e6451-3759-1237-c4ba-000c2919b6af
  302.    CSeq: 128381500 INVITE
  303.    To: <sip:213@192.168.129.176:50560;rinstance=292D7641;transport=tls>
  304.    User-Agent: Acrobits Softphone Business/3.8.2
  305.    Content-Length: 0
  306.  
  307.    ------------------------------------------------------------------------
  308. recv 532 bytes from tls/[49.172.161.250]:50560 at 11:18:49.903792:
  309.    ------------------------------------------------------------------------
  310.    SIP/2.0 180 Ringing
  311.    Via: SIP/2.0/TLS 31.102.111.134;branch=z9hG4bK5XQ58Qg22jNjr
  312.    Contact: <sip:213@192.168.129.176:50560;transport=tls>
  313.    From: "Andrea Mazzeo" <sip:207@31.102.111.134>;tag=N61aeF7Syt8yD
  314.    Call-ID: 068e6451-3759-1237-c4ba-000c2919b6af
  315.    CSeq: 128381500 INVITE
  316.    To: <sip:213@192.168.129.176:50560;rinstance=292D7641;transport=tls>;tag=09FF027B916C5C2FCA338126B4A6840A
  317.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY
  318.    Supported: replaces, path
  319.    User-Agent: Acrobits Softphone Business/3.8.2
  320.    Content-Length: 0
  321.  
  322.    ------------------------------------------------------------------------
  323. 2018-09-20 11:18:49.898470 [DEBUG] sofia.c:7291 Channel sofia/internal/213@192.168.129.176:50560 entering state [proceeding][180]
  324. 2018-09-20 11:18:49.898470 [NOTICE] sofia.c:7401 Ring-Ready sofia/internal/213@192.168.129.176:50560!
  325. 2018-09-20 11:18:49.898470 [DEBUG] switch_channel.c:3354 (sofia/internal/213@192.168.129.176:50560) Callstate Change DOWN -> RINGING
  326. 2018-09-20 11:18:49.898470 [NOTICE] mod_sofia.c:2419 Ring-Ready sofia/internal/207@pbx-186.smallunix.net!
  327.  
  328. send 879 bytes to tls/[31.102.111.132]:44832 at 11:18:49.916815:
  329.   ------------------------------------------------------------------------
  330.    SIP/2.0 180 Ringing
  331.    Via: SIP/2.0/TLS 192.168.128.158:51018;branch=z9hG4bKrXUOdwO6LSgwFeG6;rport=44832;received=31.102.111.132
  332.    From: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  333.    To: <sip:213@pbx-186.smallunix.net>;tag=mX8Hcmpp1Hjcj
  334.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  335.    CSeq: 2 INVITE
  336.    Contact: <sip:213@31.102.111.134:5061;transport=tls>
  337.    User-Agent: SWO-PBX-1.0
  338.    Accept: application/sdp
  339.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  340.    Supported: timer, path, replaces
  341.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  342.    Content-Length: 0
  343.    Remote-Party-ID: "Outbound Call" <sip:213@pbx-186.smallunix.net>;party=calling;privacy=off;screen=no
  344.  
  345.    ------------------------------------------------------------------------
  346. 2018-09-20 11:18:49.898470 [DEBUG] sofia.c:7291 Channel sofia/internal/207@pbx-186.smallunix.net entering state [early][180]
  347. 2018-09-20 11:18:49.898470 [NOTICE] switch_ivr_originate.c:527 Ring Ready sofia/internal/207@pbx-186.smallunix.net!
  348.  
  349.    ------------------------------------------------------------------------
  350. recv 972 bytes from tls/[49.172.161.250]:50560 at 11:18:51.504614:
  351.    ------------------------------------------------------------------------
  352.    SIP/2.0 200 OK
  353.    Via: SIP/2.0/TLS 31.102.111.134;branch=z9hG4bK5XQ58Qg22jNjr
  354.    Contact: <sip:213@192.168.129.176:50560;transport=tls>
  355.    From: "Andrea Mazzeo" <sip:207@31.102.111.134>;tag=N61aeF7Syt8yD
  356.    Call-ID: 068e6451-3759-1237-c4ba-000c2919b6af
  357.    CSeq: 128381500 INVITE
  358.    To: <sip:213@192.168.129.176:50560;rinstance=292D7641;transport=tls>;tag=09FF027B916C5C2FCA338126B4A6840A
  359.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY
  360.    Supported: replaces, path
  361.    Content-Type: application/sdp
  362.    User-Agent: Acrobits Softphone Business/3.8.2
  363.    Content-Length: 412
  364.  
  365.    v=0
  366.    o=- 9845989873 23518 IN IP4 172.26.170.170
  367.    s=ocpiwdk
  368.    c=IN IP4 192.168.129.176
  369.    t=0 0
  370.    m=audio 65018 RTP/SAVP 102
  371.    a=rtpmap:102 opus/48000/2
  372.    a=fmtp:102 maxplaybackrate=16000;maxaveragebitrate=30000;useinbandfec=1
  373.    a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:/t/7xNzYwWEti93oblybP9b/Vv/PW0Z/5wmEbdRl
  374.    a=ptime:20
  375.    a=zrtp-hash:1.10 13F3D6124818E7CB1E3C9ED58FDFC6194163F66FBCA9FCA3E40AA8F6D26D12B0
  376.    a=sendrecv
  377.    ------------------------------------------------------------------------
  378. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:495 Found audio zrtp-hash; setting r_sdp_audio_zrtp_hash=1.10 13F3D6124818E7CB1E3C9ED58FDFC6194163F66FBCA9FCA3E40AA8F6D26D12B0
  379. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:371 Passing a-leg remote zrtp-hash (audio) to b-leg
  380. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:377 Passing b-leg remote zrtp-hash (audio) to a-leg
  381. 2018-09-20 11:18:51.498484 [DEBUG] sofia.c:7291 Channel sofia/internal/213@192.168.129.176:50560 entering state [completing][200]
  382. 2018-09-20 11:18:51.498484 [DEBUG] sofia.c:7301 Remote SDP:
  383. v=0
  384. o=- 9845989873 23518 IN IP4 172.26.170.170
  385. s=ocpiwdk
  386. c=IN IP4 192.168.129.176
  387. t=0 0
  388. m=audio 65018 RTP/SAVP 102
  389. a=rtpmap:102 opus/48000/2
  390. a=fmtp:102 maxplaybackrate=16000;maxaveragebitrate=30000;useinbandfec=1
  391. a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:/t/7xNzYwWEti93oblybP9b/Vv/PW0Z/5wmEbdRl
  392. a=ptime:20
  393. a=zrtp-hash:1.10 13F3D6124818E7CB1E3C9ED58FDFC6194163F66FBCA9FCA3E40AA8F6D26D12B0
  394.  
  395. 2018-09-20 11:18:51.498484 [INFO] switch_channel.c:3382 sofia/internal/213@192.168.129.176:50560 Activating ZRTP passthru mode.
  396. 2018-09-20 11:18:51.498484 [NOTICE] sofia.c:7304 Pre-Answer sofia/internal/213@192.168.129.176:50560!
  397. 2018-09-20 11:18:51.498484 [DEBUG] switch_channel.c:3482 (sofia/internal/213@192.168.129.176:50560) Callstate Change RINGING -> EARLY
  398. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:495 Found audio zrtp-hash; setting r_sdp_audio_zrtp_hash=1.10 13F3D6124818E7CB1E3C9ED58FDFC6194163F66FBCA9FCA3E40AA8F6D26D12B0
  399. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:371 Passing a-leg remote zrtp-hash (audio) to b-leg
  400. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:377 Passing b-leg remote zrtp-hash (audio) to a-leg
  401. send 455 bytes to tls/[49.172.161.250]:50560 at 11:18:51.508398:
  402.    ------------------------------------------------------------------------
  403.    ACK sip:213@192.168.129.176:50560;transport=tls SIP/2.0
  404.    Via: SIP/2.0/TLS 31.102.111.134;branch=z9hG4bK7FaQcej9v41QF
  405.    Max-Forwards: 70
  406.    From: "Andrea Mazzeo" <sip:207@31.102.111.134>;tag=N61aeF7Syt8yD
  407.    To: <sip:213@192.168.129.176:50560;rinstance=292D7641;transport=tls>;tag=09FF027B916C5C2FCA338126B4A6840A
  408.    Call-ID: 068e6451-3759-1237-c4ba-000c2919b6af
  409.    CSeq: 128381500 ACK
  410.    Contact: <sip:mod_sofia@31.102.111.134:5061;transport=tls>
  411.    Content-Length: 0
  412.  
  413.    ------------------------------------------------------------------------
  414. 2018-09-20 11:18:51.498484 [DEBUG] sofia.c:7291 Channel sofia/internal/213@192.168.129.176:50560 entering state [ready][200]
  415. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:495 Found audio zrtp-hash; setting r_sdp_audio_zrtp_hash=1.10 13F3D6124818E7CB1E3C9ED58FDFC6194163F66FBCA9FCA3E40AA8F6D26D12B0
  416. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:371 Passing a-leg remote zrtp-hash (audio) to b-leg
  417. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:377 Passing b-leg remote zrtp-hash (audio) to a-leg
  418. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:1804 looking for crypto suite [AEAD_AES_256_GCM_8] in [5 AES_CM_128_HMAC_SHA1_80 inline:/t/7xNzYwWEti93oblybP9b/Vv/PW0Z/5wmEbdRl]
  419. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:1804 looking for crypto suite [AEAD_AES_128_GCM_8] in [5 AES_CM_128_HMAC_SHA1_80 inline:/t/7xNzYwWEti93oblybP9b/Vv/PW0Z/5wmEbdRl]
  420. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:1804 looking for crypto suite [AES_CM_256_HMAC_SHA1_80] in [5 AES_CM_128_HMAC_SHA1_80 inline:/t/7xNzYwWEti93oblybP9b/Vv/PW0Z/5wmEbdRl]
  421. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:1804 looking for crypto suite [AES_CM_192_HMAC_SHA1_80] in [5 AES_CM_128_HMAC_SHA1_80 inline:/t/7xNzYwWEti93oblybP9b/Vv/PW0Z/5wmEbdRl]
  422. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:1804 looking for crypto suite [AES_CM_128_HMAC_SHA1_80] in [5 AES_CM_128_HMAC_SHA1_80 inline:/t/7xNzYwWEti93oblybP9b/Vv/PW0Z/5wmEbdRl]
  423. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:1809 Found suite AES_CM_128_HMAC_SHA1_80
  424. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:1877 Set Remote Key [5 AES_CM_128_HMAC_SHA1_80 inline:/t/7xNzYwWEti93oblybP9b/Vv/PW0Z/5wmEbdRl]
  425. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:5470 Audio Codec Compare [opus:102:48000:20:0:1]/[opus:116:48000:20:0:2]
  426. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:5525 Audio Codec Compare [opus:116:48000:20:0:2] ++++ is saved as a match
  427. 2018-09-20 11:18:51.498484 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps]
  428. 2018-09-20 11:18:51.498484 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [72000bps]
  429. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:3773 Set Codec sofia/internal/213@192.168.129.176:50560 opus/48000 20 ms 960 samples 0 bits 1 channels
  430. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_codec.c:111 sofia/internal/213@192.168.129.176:50560 Original read codec set to opus:116
  431. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:5794 No 2833 in SDP.  Disable 2833 dtmf and switch to INFO
  432. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:8503 AUDIO RTP [sofia/internal/213@192.168.129.176:50560] 31.102.111.134 port 21194 -> 192.168.129.176 port 65018 codec: 102 ms: 20
  433. 2018-09-20 11:18:51.498484 [DEBUG] switch_rtp.c:4282 Starting timer [soft] 960 bytes per 20ms
  434. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:8837 sofia/internal/213@192.168.129.176:50560 Set rtp dtmf delay to 40
  435. 2018-09-20 11:18:51.498484 [INFO] switch_rtp.c:4086 Activating audio Secure RTP SEND
  436. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
  437. 2018-09-20 11:18:51.498484 [INFO] switch_rtp.c:4064 Activating audio Secure RTP RECV
  438. 2018-09-20 11:18:51.498484 [INFO] switch_core_media.c:8855 Activating ZRTP PROXY MODE
  439. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:8856 Disable NOTIMER_DURING_BRIDGE
  440. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_media.c:8858 Activating audio UDPTL mode
  441. 2018-09-20 11:18:51.498484 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
  442. 2018-09-20 11:18:51.498484 [NOTICE] sofia.c:8429 Channel [sofia/internal/213@192.168.129.176:50560] has been answered
  443. send 1394 bytes to tls/[31.102.111.132]:44832 at 11:18:51.529779:
  444.    ------------------------------------------------------------------------
  445.    SIP/2.0 200 OK
  446.    Via: SIP/2.0/TLS 192.168.128.158:51018;branch=z9hG4bKrXUOdwO6LSgwFeG6;rport=44832;received=31.102.111.132
  447.    From: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  448.    To: <sip:213@pbx-186.smallunix.net>;tag=mX8Hcmpp1Hjcj
  449.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  450.    CSeq: 2 INVITE
  451.    Contact: <sip:213@31.102.111.134:5061;transport=tls>
  452.    User-Agent: SWO-PBX-1.0
  453.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  454.    Supported: timer, path, replaces
  455.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  456.    Session-Expires: 120;refresher=uas
  457.    Content-Type: application/sdp
  458.    Content-Disposition: session
  459.    Content-Length: 446
  460.    Remote-Party-ID: "Outbound Call" <sip:213@pbx-186.smallunix.net>;party=calling;privacy=off;screen=no
  461.  
  462.    v=0
  463.    o=FreeSWITCH 1537411117 1537411118 IN IP4 31.102.111.134
  464.    s=FreeSWITCH
  465.    c=IN IP4 31.102.111.134
  466.    t=0 0
  467.    m=audio 24014 RTP/SAVP 103 101
  468.    a=rtpmap:103 opus/48000/2
  469.    a=fmtp:103 useinbandfec=1
  470.    a=rtpmap:101 telephone-event/8000
  471.    a=fmtp:101 0-16
  472.    a=ptime:20
  473.    a=zrtp-hash:1.10 13F3D6124818E7CB1E3C9ED58FDFC6194163F66FBCA9FCA3E40AA8F6D26D12B0
  474.    a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:waW2eGxCtNY+qbRx/MS+yPvOAFZGeAYjZIQ58eXL
  475.    m=audio 0 RTP/AVP 19
  476.    ------------------------------------------------------------------------
  477. 2018-09-20 11:18:51.518472 [DEBUG] switch_channel.c:3781 (sofia/internal/207@pbx-186.smallunix.net) Callstate Change EARLY -> ACTIVE
  478. 2018-09-20 11:18:51.518472 [DEBUG] sofia.c:7291 Channel sofia/internal/207@pbx-186.smallunix.net entering state [completed][200]
  479. 2018-09-20 11:18:51.518472 [DEBUG] switch_ivr_originate.c:3722 Originate Resulted in Success: [sofia/internal/213@192.168.129.176:50560]
  480. 2018-09-20 11:18:51.518472 [DEBUG] switch_ivr_originate.c:3722 Originate Resulted in Success: [sofia/internal/213@192.168.129.176:50560]
  481. 2018-09-20 11:18:51.518472 [DEBUG] switch_ivr_bridge.c:1744 (sofia/internal/213@192.168.129.176:50560) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  482. 2018-09-20 11:18:51.518472 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/213@192.168.129.176:50560) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 244)
  483. 2018-09-20 11:18:51.518472 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/213@192.168.129.176:50560) State EXCHANGE_MEDIA
  484. 2018-09-20 11:18:51.518472 [DEBUG] mod_sofia.c:645 SOFIA EXCHANGE_MEDIA
  485.    ------------------------------------------------------------------------
  486. send 1394 bytes to tls/[31.102.111.132]:44832 at 11:18:52.030377:
  487.    ------------------------------------------------------------------------
  488.    SIP/2.0 200 OK
  489.    Via: SIP/2.0/TLS 192.168.128.158:51018;branch=z9hG4bKrXUOdwO6LSgwFeG6;rport=44832;received=31.102.111.132
  490.    From: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  491.    To: <sip:213@pbx-186.smallunix.net>;tag=mX8Hcmpp1Hjcj
  492.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  493.    CSeq: 2 INVITE
  494.    Contact: <sip:213@31.102.111.134:5061;transport=tls>
  495.    User-Agent: SWO-PBX-1.0
  496.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  497.    Supported: timer, path, replaces
  498.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  499.    Session-Expires: 120;refresher=uas
  500.    Content-Type: application/sdp
  501.    Content-Disposition: session
  502.    Content-Length: 446
  503.    Remote-Party-ID: "Outbound Call" <sip:213@pbx-186.smallunix.net>;party=calling;privacy=off;screen=no
  504.  
  505.    v=0
  506.    o=FreeSWITCH 1537411117 1537411118 IN IP4 31.102.111.134
  507.    s=FreeSWITCH
  508.    c=IN IP4 31.102.111.134
  509.    t=0 0
  510.    m=audio 24014 RTP/SAVP 103 101
  511.    a=rtpmap:103 opus/48000/2
  512.    a=fmtp:103 useinbandfec=1
  513.    a=rtpmap:101 telephone-event/8000
  514.    a=fmtp:101 0-16
  515.    a=ptime:20
  516.    a=zrtp-hash:1.10 13F3D6124818E7CB1E3C9ED58FDFC6194163F66FBCA9FCA3E40AA8F6D26D12B0
  517.    a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:waW2eGxCtNY+qbRx/MS+yPvOAFZGeAYjZIQ58eXL
  518.    m=audio 0 RTP/AVP 19
  519.    ------------------------------------------------------------------------
  520. 2018-09-20 11:18:52.038459 [INFO] switch_rtp.c:7492 Auto Changing audio port from 192.168.129.176:65018 to 49.172.161.250:65018
  521. recv 426 bytes from tls/[31.102.111.132]:44832 at 11:18:52.289637:
  522.    ------------------------------------------------------------------------
  523.    ACK sip:213@31.102.111.134:5061;transport=tls SIP/2.0
  524.    Via: SIP/2.0/TLS 192.168.128.158:51018;branch=z9hG4bKoFuJF4Cb9Hd4lyTu;rport
  525.    Max-Forwards: 70
  526.    To: <sip:213@pbx-186.smallunix.net>;tag=mX8Hcmpp1Hjcj
  527.    From: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  528.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  529.    CSeq: 2 ACK
  530.    User-Agent: Acrobits Softphone Business/3.8.2
  531.    Content-Length: 0
  532.  
  533.    ------------------------------------------------------------------------
  534. 2018-09-20 11:18:52.278458 [DEBUG] sofia.c:7291 Channel sofia/internal/207@pbx-186.smallunix.net entering state [ready][200]
  535. recv 426 bytes from tls/[31.102.111.132]:44832 at 11:18:52.331275:
  536.    ------------------------------------------------------------------------
  537.    ACK sip:213@31.102.111.134:5061;transport=tls SIP/2.0
  538.    Via: SIP/2.0/TLS 192.168.128.158:51018;branch=z9hG4bKJyzi5qUSbdZCQYMw;rport
  539.    Max-Forwards: 70
  540.    To: <sip:213@pbx-186.smallunix.net>;tag=mX8Hcmpp1Hjcj
  541.    From: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  542.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  543.    CSeq: 2 ACK
  544.    User-Agent: Acrobits Softphone Business/3.8.2
  545.    Content-Length: 0
  546.  
  547.    ------------------------------------------------------------------------
  548. 2018-09-20 11:18:52.338471 [INFO] switch_rtp.c:7492 Auto Changing audio port from 192.168.128.158:59416 to 31.102.111.132:10299
  549.    ------------------------------------------------------------------------
  550. recv 595 bytes from tls/[49.172.161.250]:50560 at 11:18:57.814420:
  551.    ------------------------------------------------------------------------
  552.    BYE sip:mod_sofia@31.102.111.134:5061;transport=tls SIP/2.0
  553.    Via: SIP/2.0/TLS 192.168.129.176:50560;branch=z9hG4bKJ81ubNMd5e7Vl3tS;rport
  554.    Contact: <sip:213@192.168.129.176:50560;transport=tls>
  555.    Max-Forwards: 70
  556.    From: <sip:213@192.168.129.176:50560;rinstance=292D7641;transport=tls>;tag=09FF027B916C5C2FCA338126B4A6840A
  557.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY
  558.    Supported: replaces, path
  559.    To: "Andrea Mazzeo" <sip:207@31.102.111.134>;tag=N61aeF7Syt8yD
  560.    Call-ID: 068e6451-3759-1237-c4ba-000c2919b6af
  561.    CSeq: 1 BYE
  562.    User-Agent: Acrobits Softphone Business/3.8.2
  563.    Content-Length: 0
  564.  
  565.    ------------------------------------------------------------------------
  566. 2018-09-20 11:18:57.798460 [NOTICE] sofia.c:1079 Hangup sofia/internal/213@192.168.129.176:50560 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  567. send 544 bytes to tls/[49.172.161.250]:50560 at 11:18:57.816702:
  568.    ------------------------------------------------------------------------
  569.    SIP/2.0 200 OK
  570.    Via: SIP/2.0/TLS 192.168.129.176:50560;branch=z9hG4bKJ81ubNMd5e7Vl3tS;rport=50560;received=49.172.161.250
  571.    From: <sip:213@192.168.129.176:50560;rinstance=292D7641;transport=tls>;tag=09FF027B916C5C2FCA338126B4A6840A
  572.    To: "Andrea Mazzeo" <sip:207@31.102.111.134>;tag=N61aeF7Syt8yD
  573.    Call-ID: 068e6451-3759-1237-c4ba-000c2919b6af
  574.    CSeq: 1 BYE
  575.    User-Agent: SWO-PBX-1.0
  576.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  577.    Supported: timer, path, replaces
  578.    Content-Length: 0
  579.  
  580.    ------------------------------------------------------------------------
  581. 2018-09-20 11:18:57.798460 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/internal/213@192.168.129.176:50560]
  582. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/213@192.168.129.176:50560) State EXCHANGE_MEDIA going to sleep
  583. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/213@192.168.129.176:50560) Running State Change CS_HANGUP (Cur 2 Tot 244)
  584. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/213@192.168.129.176:50560) Callstate Change ACTIVE -> HANGUP
  585. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/213@192.168.129.176:50560) State HANGUP
  586. 2018-09-20 11:18:57.798460 [DEBUG] mod_sofia.c:449 Channel sofia/internal/213@192.168.129.176:50560 hanging up, cause: NORMAL_CLEARING
  587. 2018-09-20 11:18:57.798460 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/internal/207@pbx-186.smallunix.net]
  588. 2018-09-20 11:18:57.798460 [DEBUG] switch_ivr_bridge.c:1843 sofia/internal/213@192.168.129.176:50560 skip receive message [TRANSFER] (channel is hungup already)
  589. 2018-09-20 11:18:57.798460 [NOTICE] switch_ivr_bridge.c:1895 Hangup sofia/internal/207@pbx-186.smallunix.net [CS_EXECUTE] [NORMAL_CLEARING]
  590. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:60 sofia/internal/213@192.168.129.176:50560 Standard HANGUP, cause: NORMAL_CLEARING
  591. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/213@192.168.129.176:50560) State HANGUP going to sleep
  592. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/213@192.168.129.176:50560) State Change CS_HANGUP -> CS_REPORTING
  593. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/213@192.168.129.176:50560) Running State Change CS_REPORTING (Cur 2 Tot 244)
  594. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/213@192.168.129.176:50560) State REPORTING
  595. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:174 sofia/internal/213@192.168.129.176:50560 Standard REPORTING, cause: NORMAL_CLEARING
  596. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/213@192.168.129.176:50560) State REPORTING going to sleep
  597. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_session.c:2885 sofia/internal/207@pbx-186.smallunix.net skip receive message [PHONE_EVENT] (channel is hungup already)
  598. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/207@pbx-186.smallunix.net) State EXECUTE going to sleep
  599. 2018-09-20 11:18:57.798460 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/207@pbx-186.smallunix.net) Running State Change CS_HANGUP (Cur 2 Tot 244)
  600. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/207@pbx-186.smallunix.net) Callstate Change ACTIVE -> HANGUP
  601. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/213@192.168.129.176:50560) State Change CS_REPORTING -> CS_DESTROY
  602. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_session.c:1713 Session 244 (sofia/internal/213@192.168.129.176:50560) Locked, Waiting on external entities
  603. 2018-09-20 11:18:57.818443 [NOTICE] switch_core_session.c:1731 Session 244 (sofia/internal/213@192.168.129.176:50560) Ended
  604. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/207@pbx-186.smallunix.net) State HANGUP
  605. 2018-09-20 11:18:57.818443 [NOTICE] switch_core_session.c:1735 Close Channel sofia/internal/213@192.168.129.176:50560 [CS_DESTROY]
  606. 2018-09-20 11:18:57.818443 [DEBUG] mod_sofia.c:443 sofia/internal/207@pbx-186.smallunix.net Overriding SIP cause 480 with 200 from the other leg
  607. 2018-09-20 11:18:57.818443 [DEBUG] mod_sofia.c:449 Channel sofia/internal/207@pbx-186.smallunix.net hanging up, cause: NORMAL_CLEARING
  608. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/213@192.168.129.176:50560) Running State Change CS_DESTROY (Cur 1 Tot 244)
  609. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/213@192.168.129.176:50560) State DESTROY
  610. 2018-09-20 11:18:57.818443 [DEBUG] mod_sofia.c:354 sofia/internal/213@192.168.129.176:50560 SOFIA DESTROY
  611. 2018-09-20 11:18:57.818443 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  612. 2018-09-20 11:18:57.818443 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  613. 2018-09-20 11:18:57.818443 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  614. 2018-09-20 11:18:57.818443 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  615. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:181 sofia/internal/213@192.168.129.176:50560 Standard DESTROY
  616. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/213@192.168.129.176:50560) State DESTROY going to sleep
  617. 2018-09-20 11:18:57.818443 [DEBUG] mod_sofia.c:502 Sending BYE to sofia/internal/207@pbx-186.smallunix.net
  618. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:60 sofia/internal/207@pbx-186.smallunix.net Standard HANGUP, cause: NORMAL_CLEARING
  619. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/207@pbx-186.smallunix.net) State HANGUP going to sleep
  620. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/207@pbx-186.smallunix.net) State Change CS_HANGUP -> CS_REPORTING
  621. send 589 bytes to tls/[31.102.111.132]:44832 at 11:18:57.819997:
  622.    ------------------------------------------------------------------------
  623.    BYE sip:207@192.168.128.158:51018;transport=tls SIP/2.0
  624.    Via: SIP/2.0/TLS 31.102.111.134;branch=z9hG4bK91v8F4KgQpeXp
  625.    Max-Forwards: 70
  626.    From: <sip:213@pbx-186.smallunix.net>;tag=mX8Hcmpp1Hjcj
  627.    To: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  628.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  629.    CSeq: 128381504 BYE
  630.    User-Agent: SWO-PBX-1.0
  631.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  632.    Supported: timer, path, replaces
  633.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  634. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/207@pbx-186.smallunix.net) Running State Change CS_REPORTING (Cur 1 Tot 244)
  635.    Content-Length: 0
  636.  
  637.    ------------------------------------------------------------------------
  638. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/207@pbx-186.smallunix.net) State REPORTING
  639. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:174 sofia/internal/207@pbx-186.smallunix.net Standard REPORTING, cause: NORMAL_CLEARING
  640. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/207@pbx-186.smallunix.net) State REPORTING going to sleep
  641. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/207@pbx-186.smallunix.net) State Change CS_REPORTING -> CS_DESTROY
  642. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_session.c:1713 Session 243 (sofia/internal/207@pbx-186.smallunix.net) Locked, Waiting on external entities
  643. 2018-09-20 11:18:57.818443 [NOTICE] switch_core_session.c:1731 Session 243 (sofia/internal/207@pbx-186.smallunix.net) Ended
  644. 2018-09-20 11:18:57.818443 [NOTICE] switch_core_session.c:1735 Close Channel sofia/internal/207@pbx-186.smallunix.net [CS_DESTROY]
  645. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/207@pbx-186.smallunix.net) Running State Change CS_DESTROY (Cur 0 Tot 244)
  646. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/207@pbx-186.smallunix.net) State DESTROY
  647. 2018-09-20 11:18:57.818443 [DEBUG] mod_sofia.c:354 sofia/internal/207@pbx-186.smallunix.net SOFIA DESTROY
  648. 2018-09-20 11:18:57.818443 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  649. 2018-09-20 11:18:57.818443 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  650. 2018-09-20 11:18:57.818443 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  651. 2018-09-20 11:18:57.818443 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  652. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:181 sofia/internal/207@pbx-186.smallunix.net Standard DESTROY
  653. 2018-09-20 11:18:57.818443 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/207@pbx-186.smallunix.net) State DESTROY going to sleep
  654.  
  655.    ------------------------------------------------------------------------
  656. recv 501 bytes from tls/[31.102.111.132]:44832 at 11:19:00.095403:
  657.    ------------------------------------------------------------------------
  658.    SIP/2.0 200 OK
  659.    Via: SIP/2.0/TLS 31.102.111.134;branch=z9hG4bK91v8F4KgQpeXp
  660.    Contact: <sip:207@192.168.128.158:51018;transport=tls>
  661.    From: <sip:213@pbx-186.smallunix.net>;tag=mX8Hcmpp1Hjcj
  662.    Call-ID: F4BB678B69EC1AEC3231902A3C0AEA5F28451673
  663.    CSeq: 128381504 BYE
  664.    To: "Andrea Mazzeo" <sip:207@pbx-186.smallunix.net>;tag=45D27BDABDFA056A12161380A06BED82
  665.    Allow: OPTIONS, INVITE, ACK, REFER, CANCEL, BYE, NOTIFY
  666.    Supported: replaces, path
  667.    User-Agent: Acrobits Softphone Business/3.8.2
  668.    Content-Length: 0
  669.  

Reply to "zRTP + OPUS issue"

captcha