FreeSWITCH Pastebin

通过网关外拨, FS没有发送RTP(trace日志)

From lzpong, 7 Years ago, written in FreeSWITCH.
- view diff
URL https://pastebin.freeswitch.org/view/f90e48f9
Embed
Download Paste or View Raw
  1. recv 817 bytes from udp/[192.168.1.33]:5060 at 14:45:58.514350:
  2.    ------------------------------------------------------------------------
  3.    INVITE sip:9186******73@127.0.0.1;user=phone SIP/2.0
  4.    Via: SIP/2.0/UDP 192.168.1.33:5060;branch=z9hG4bK1202;rport
  5.    From: "8005" <sip:8005@127.0.0.1;user=phone>;tag=3cd16e0589b326696
  6.    To: <sip:9186******73@127.0.0.1;user=phone>
  7.    Call-ID: 3cd16e0589b39777@192.168.1.33
  8.    CSeq: 2081 INVITE
  9.    Contact: "8005" <sip:8005@192.168.1.33:5060>
  10.    Max-Forwards: 70
  11.    User-Agent: SIPUA
  12.    Expires: 120
  13.    Supported: 100rel
  14.    P-Preferred-Identity: "8005" <sip:8005@127.0.0.1;user=phone>
  15.    Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, UPDATE, PRACK
  16.    Content-Type: application/sdp
  17.    Content-Length: 206
  18.    
  19.    v=0
  20.    o=8005 20000001 31 IN IP4 192.168.1.33
  21.    s=A call
  22.    c=IN IP4 192.168.1.33
  23.    t=0 0
  24.    m=audio 10000 RTP/AVP 18 0 8
  25.    a=rtpmap:18 G729/8000
  26.    a=rtpmap:0 PCMU/8000
  27.    a=rtpmap:8 PCMA/8000
  28.    a=ptime:20
  29.    a=sendrecv
  30.    ------------------------------------------------------------------------
  31. send 359 bytes to udp/[192.168.1.33]:5060 at 14:45:58.514671:
  32.    ------------------------------------------------------------------------
  33.    SIP/2.0 100 Trying
  34.    Via: SIP/2.0/UDP 192.168.1.33:5060;branch=z9hG4bK1202;rport=5060
  35.    From: "8005" <sip:8005@127.0.0.1;user=phone>;tag=3cd16e0589b326696
  36.    To: <sip:9186******73@127.0.0.1;user=phone>
  37.    Call-ID: 3cd16e0589b39777@192.168.1.33
  38.    CSeq: 2081 INVITE
  39.    User-Agent: FreeSWITCH-mod_sofia/1.5.15b+git~20141220T224621Z~0a0b9262b4~64bit
  40.    Content-Length: 0
  41.    
  42.    ------------------------------------------------------------------------
  43. 2017-04-14 14:45:58.512503 [NOTICE] switch_channel.c:1055 New Channel sofia/internal/8005@127.0.0.1 [044e242e-20de-11e7-ba33-f7c335f7649a]
  44. 2017-04-14 14:45:58.512503 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  45. 2017-04-14 14:45:58.512503 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  46. 2017-04-14 14:45:58.512503 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/8005@127.0.0.1) Running State Change CS_NEW
  47. 2017-04-14 14:45:58.512503 [DEBUG] sofia.c:8834 sofia/internal/8005@127.0.0.1 receiving invite from 192.168.1.33:5060 version: 1.5.15b git 0a0b926 2014-12-20 22:46:21Z 64bit
  48. 2017-04-14 14:45:58.512503 [DEBUG] sofia.c:9001 IP 192.168.1.33 Rejected by acl "domains". Falling back to Digest auth.
  49. 2017-04-14 14:45:58.512503 [DEBUG] switch_core_state_machine.c:491 (sofia/internal/8005@127.0.0.1) State NEW
  50. send 859 bytes to udp/[192.168.1.33]:5060 at 14:45:58.515399:
  51.    ------------------------------------------------------------------------
  52.    SIP/2.0 407 Proxy Authentication Required
  53.    Via: SIP/2.0/UDP 192.168.1.33:5060;branch=z9hG4bK1202;rport=5060
  54.    From: "8005" <sip:8005@127.0.0.1;user=phone>;tag=3cd16e0589b326696
  55.    To: <sip:9186******73@127.0.0.1;user=phone>;tag=1Zmp3ej28685B
  56.    Call-ID: 3cd16e0589b39777@192.168.1.33
  57.    CSeq: 2081 INVITE
  58.    User-Agent: FreeSWITCH-mod_sofia/1.5.15b+git~20141220T224621Z~0a0b9262b4~64bit
  59.    Accept: application/sdp
  60.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  61.    Supported: timer, path, replaces
  62.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  63.    Proxy-Authenticate: Digest realm="127.0.0.1", nonce="044e2e1a-20de-11e7-ba34-f7c335f7649a", algorithm=MD5, qop="auth"
  64.    Content-Length: 0
  65.    
  66.    ------------------------------------------------------------------------
  67. 2017-04-14 14:45:58.512503 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  68. 2017-04-14 14:45:58.512503 [DEBUG] sofia.c:2067 detaching session 044e242e-20de-11e7-ba33-f7c335f7649a
  69. recv 320 bytes from udp/[192.168.1.33]:5060 at 14:45:58.535989:
  70.    ------------------------------------------------------------------------
  71.    ACK sip:9186******73@127.0.0.1;user=phone SIP/2.0
  72.    Via: SIP/2.0/UDP 192.168.1.33:5060;branch=z9hG4bK1202;rport
  73.    From: "8005" <sip:8005@127.0.0.1;user=phone>;tag=3cd16e0589b326696
  74.    To: <sip:9186******73@127.0.0.1;user=phone>;tag=1Zmp3ej28685B
  75.    Call-ID: 3cd16e0589b39777@192.168.1.33
  76.    CSeq: 2081 ACK
  77.    Content-Length: 0
  78.    
  79.    ------------------------------------------------------------------------
  80. recv 1051 bytes from udp/[192.168.1.33]:5060 at 14:45:58.537349:
  81.    ------------------------------------------------------------------------
  82.    INVITE sip:9186******73@127.0.0.1;user=phone SIP/2.0
  83.    Via: SIP/2.0/UDP 192.168.1.33:5060;branch=z9hG4bK19726;rport
  84.    From: "8005" <sip:8005@127.0.0.1;user=phone>;tag=3cd16e0589b326696
  85.    To: <sip:9186******73@127.0.0.1;user=phone>
  86.    Call-ID: 3cd16e0589b39777@192.168.1.33
  87.    CSeq: 2082 INVITE
  88.    Contact: "8005" <sip:8005@192.168.1.33:5060>
  89.    Proxy-Authorization: Digest username="8005", realm="127.0.0.1", nonce="044e2e1a-20de-11e7-ba34-f7c335f7649a", uri="sip:127.0.0.1", response="901c2c5bf4cd4b618c9d52a03ce07108", algorithm=MD5, cnonce="000010cc", qop=auth, nc=00000001
  90.    Max-Forwards: 70
  91.    User-Agent: SIPUA
  92.    Expires: 120
  93.    Supported: 100rel
  94.    P-Preferred-Identity: "8005" <sip:8005@127.0.0.1;user=phone>
  95.    Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, UPDATE, PRACK
  96.    Content-Type: application/sdp
  97.    Content-Length: 206
  98.    
  99.    v=0
  100.    o=8005 20000001 31 IN IP4 192.168.1.33
  101.    s=A call
  102.    c=IN IP4 192.168.1.33
  103.    t=0 0
  104.    m=audio 10000 RTP/AVP 18 0 8
  105.    a=rtpmap:18 G729/8000
  106.    a=rtpmap:0 PCMU/8000
  107.    a=rtpmap:8 PCMA/8000
  108.    a=ptime:20
  109.    a=sendrecv
  110.    ------------------------------------------------------------------------
  111. send 360 bytes to udp/[192.168.1.33]:5060 at 14:45:58.537639:
  112.    ------------------------------------------------------------------------
  113.    SIP/2.0 100 Trying
  114.    Via: SIP/2.0/UDP 192.168.1.33:5060;branch=z9hG4bK19726;rport=5060
  115.    From: "8005" <sip:8005@127.0.0.1;user=phone>;tag=3cd16e0589b326696
  116.    To: <sip:9186******73@127.0.0.1;user=phone>
  117.    Call-ID: 3cd16e0589b39777@192.168.1.33
  118.    CSeq: 2082 INVITE
  119.    User-Agent: FreeSWITCH-mod_sofia/1.5.15b+git~20141220T224621Z~0a0b9262b4~64bit
  120.    Content-Length: 0
  121.    
  122.    ------------------------------------------------------------------------
  123. 2017-04-14 14:45:58.532512 [DEBUG] sofia.c:2175 Re-attaching to session 044e242e-20de-11e7-ba33-f7c335f7649a
  124. 2017-04-14 14:45:58.532512 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  125. 2017-04-14 14:45:58.532512 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  126. 2017-04-14 14:45:58.552511 [DEBUG] sofia.c:8834 sofia/internal/8005@127.0.0.1 receiving invite from 192.168.1.33:5060 version: 1.5.15b git 0a0b926 2014-12-20 22:46:21Z 64bit
  127. 2017-04-14 14:45:58.552511 [DEBUG] sofia.c:9001 IP 192.168.1.33 Rejected by acl "domains". Falling back to Digest auth.
  128. 2017-04-14 14:45:58.552511 [DEBUG] sofia.c:6614 Channel sofia/internal/8005@127.0.0.1 entering state [received][100]
  129. 2017-04-14 14:45:58.552511 [DEBUG] sofia.c:6624 Remote SDP:
  130. v=0
  131. o=8005 20000001 31 IN IP4 192.168.1.33
  132. s=A call
  133. c=IN IP4 192.168.1.33
  134. t=0 0
  135. m=audio 10000 RTP/AVP 18 0 8
  136. a=rtpmap:18 G729/8000
  137. a=rtpmap:0 PCMU/8000
  138. a=rtpmap:8 PCMA/8000
  139. a=ptime:20
  140.  
  141. 2017-04-14 14:45:58.552511 [DEBUG] sofia.c:6890 (sofia/internal/8005@127.0.0.1) State Change CS_NEW -> CS_INIT
  142. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  143. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/8005@127.0.0.1) Running State Change CS_INIT
  144. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/8005@127.0.0.1) State INIT
  145. 2017-04-14 14:45:58.552511 [DEBUG] mod_sofia.c:87 sofia/internal/8005@127.0.0.1 SOFIA INIT
  146. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:40 sofia/internal/8005@127.0.0.1 Standard INIT
  147. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/8005@127.0.0.1) State Change CS_INIT -> CS_ROUTING
  148. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  149. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/8005@127.0.0.1) State INIT going to sleep
  150. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/8005@127.0.0.1) Running State Change CS_ROUTING
  151. 2017-04-14 14:45:58.552511 [DEBUG] switch_channel.c:2184 (sofia/internal/8005@127.0.0.1) Callstate Change DOWN -> RINGING
  152. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/8005@127.0.0.1) State ROUTING
  153. 2017-04-14 14:45:58.552511 [DEBUG] mod_sofia.c:123 sofia/internal/8005@127.0.0.1 SOFIA ROUTING
  154. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:166 sofia/internal/8005@127.0.0.1 Standard ROUTING
  155. 2017-04-14 14:45:58.552511 [INFO] mod_dialplan_xml.c:635 Processing 8005 <8005>->9186******73 in context default
  156. Dialplan: sofia/internal/8005@127.0.0.1 parsing [default->tod_example] continue=true
  157. Dialplan: sofia/internal/8005@127.0.0.1 Date/Time Match (PASS) [tod_example] break=on-true
  158. Dialplan: sofia/internal/8005@127.0.0.1 Action set(open=true)
  159. Dialplan: sofia/internal/8005@127.0.0.1 parsing [default->holiday_example] continue=true
  160. Dialplan: sofia/internal/8005@127.0.0.1 Date/TimeMatch (FAIL) [holiday_example] break=on-false
  161. Dialplan: sofia/internal/8005@127.0.0.1 parsing [default->Local_Extension] continue=false
  162. Dialplan: sofia/internal/8005@127.0.0.1 Regex (FAIL) [Local_Extension] destination_number(9186******73) =~ /^[18]0\d{2}$/ break=on-false
  163. Dialplan: sofia/internal/8005@127.0.0.1 parsing [default->call_out3] continue=false
  164. Dialplan: sofia/internal/8005@127.0.0.1 Regex (PASS) [call_out3] destination_number(9186******73) =~ /^9(\d+)$/ break=on-false
  165. Dialplan: sofia/internal/8005@127.0.0.1 Action log(INFO ${sip_from_user})
  166. Dialplan: sofia/internal/8005@127.0.0.1 Action bridge({originion_caller_id_name=${outbound_caller_id_number},origination_caller_id_number=${outbound_caller_id_number}}sofia/external/186******73@192.168.1.101)
  167. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/8005@127.0.0.1) State Change CS_ROUTING -> CS_EXECUTE
  168. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  169. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/8005@127.0.0.1) State ROUTING going to sleep
  170. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/8005@127.0.0.1) Running State Change CS_EXECUTE
  171. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/8005@127.0.0.1) State EXECUTE
  172. 2017-04-14 14:45:58.552511 [DEBUG] mod_sofia.c:178 sofia/internal/8005@127.0.0.1 SOFIA EXECUTE
  173. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:258 sofia/internal/8005@127.0.0.1 Standard EXECUTE
  174. EXECUTE sofia/internal/8005@127.0.0.1 set(open=true)
  175. 2017-04-14 14:45:58.552511 [DEBUG] mod_dptools.c:1435 sofia/internal/8005@127.0.0.1 SET [open]=[true]
  176. EXECUTE sofia/internal/8005@127.0.0.1 log(INFO 8005)
  177. 2017-04-14 14:45:58.552511 [INFO] mod_dptools.c:1628 8005
  178. EXECUTE sofia/internal/8005@127.0.0.1 bridge({originion_caller_id_name=0000000000,origination_caller_id_number=0000000000}sofia/external/186******73@192.168.1.101)
  179. 2017-04-14 14:45:58.552511 [DEBUG] switch_ivr_originate.c:2103 Parsing global variables
  180. 2017-04-14 14:45:58.552511 [DEBUG] switch_event.c:1688 Parsing variable [originion_caller_id_name]=[0000000000]
  181. 2017-04-14 14:45:58.552511 [DEBUG] switch_event.c:1688 Parsing variable [origination_caller_id_number]=[0000000000]
  182. 2017-04-14 14:45:58.552511 [NOTICE] switch_channel.c:1055 New Channel sofia/external/186******73@192.168.1.101 [0454d666-20de-11e7-ba3c-f7c335f7649a]
  183. 2017-04-14 14:45:58.552511 [DEBUG] mod_sofia.c:4627 (sofia/external/186******73@192.168.1.101) State Change CS_NEW -> CS_INIT
  184. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  185. 2017-04-14 14:45:58.552511 [DEBUG] mod_sofia.c:4697 [zrtp_passthru] Setting a-leg inherit_codec=true
  186. 2017-04-14 14:45:58.552511 [DEBUG] mod_sofia.c:4700 [zrtp_passthru] Setting b-leg absolute_codec_string='PCMU@8000h@20i@64000b,PCMA@8000h@20i@64000b'
  187. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:472 (sofia/external/186******73@192.168.1.101) Running State Change CS_INIT
  188. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:512 (sofia/external/186******73@192.168.1.101) State INIT
  189. 2017-04-14 14:45:58.552511 [DEBUG] mod_sofia.c:87 sofia/external/186******73@192.168.1.101 SOFIA INIT
  190. 2017-04-14 14:45:58.552511 [DEBUG] sofia_glue.c:1232 sofia/external/186******73@192.168.1.101 sending invite version: 1.5.15b git 0a0b926 2014-12-20 22:46:21Z 64bit
  191. Local SDP:
  192. v=0
  193. o=FreeSWITCH 1492122818 1492122819 IN IP4 192.168.1.246
  194. s=FreeSWITCH
  195. c=IN IP4 192.168.1.246
  196. t=0 0
  197. m=audio 29540 RTP/AVP 0 8 101 13
  198. a=rtpmap:0 PCMU/8000
  199. a=rtpmap:8 PCMA/8000
  200. a=rtpmap:101 telephone-event/8000
  201. a=fmtp:101 0-16
  202. a=ptime:20
  203. a=sendrecv
  204.  
  205. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:40 sofia/external/186******73@192.168.1.101 Standard INIT
  206. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:48 (sofia/external/186******73@192.168.1.101) State Change CS_INIT -> CS_ROUTING
  207. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  208. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:512 (sofia/external/186******73@192.168.1.101) State INIT going to sleep
  209. send 1068 bytes to udp/[192.168.1.101]:5060 at 14:45:58.559681:
  210.    ------------------------------------------------------------------------
  211.    INVITE sip:186******73@192.168.1.101 SIP/2.0
  212.    Via: SIP/2.0/UDP 192.168.1.246:5080;rport;branch=z9hG4bKrSSavg44NcDQN
  213.    Max-Forwards: 69
  214.    From: "Extension 8005" <sip:0000000000@192.168.1.246>;tag=SygvtFjSyD4Hg
  215.    To: <sip:186******73@192.168.1.101>
  216.    Call-ID: dbb3399b-9b80-1235-b997-000bab7a8683
  217.    CSeq: 105740115 INVITE
  218.    Contact: <sip:mod_sofia@192.168.1.246:5080>
  219.    User-Agent: FreeSWITCH-mod_sofia/1.5.15b+git~20141220T224621Z~0a0b9262b4~64bit
  220.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  221.    Supported: timer, path, replaces
  222.    Allow-Events: talk, hold, conference, refer
  223.    Privacy: none
  224.    Content-Type: application/sdp
  225.    Content-Disposition: session
  226.    Content-Length: 249
  227.    X-FS-Support: update_display,send_info
  228.    P-Asserted-Identity: "Extension 8005" <sip:0000000000@192.168.1.246>
  229.    
  230.    v=0
  231.    o=FreeSWITCH 1492122818 1492122819 IN IP4 192.168.1.246
  232.    s=FreeSWITCH
  233.    c=IN IP4 192.168.1.246
  234.    t=0 0
  235.    m=audio 29540 RTP/AVP 0 8 101 13
  236.    a=rtpmap:0 PCMU/8000
  237.    a=rtpmap:8 PCMA/8000
  238.    a=rtpmap:101 telephone-event/8000
  239.    a=fmtp:101 0-16
  240.    a=ptime:20
  241.    ------------------------------------------------------------------------
  242. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  243. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:472 (sofia/external/186******73@192.168.1.101) Running State Change CS_ROUTING
  244. 2017-04-14 14:45:58.552511 [DEBUG] sofia.c:6614 Channel sofia/external/186******73@192.168.1.101 entering state [calling][0]
  245. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:528 (sofia/external/186******73@192.168.1.101) State ROUTING
  246. 2017-04-14 14:45:58.552511 [DEBUG] mod_sofia.c:123 sofia/external/186******73@192.168.1.101 SOFIA ROUTING
  247. 2017-04-14 14:45:58.552511 [DEBUG] switch_ivr_originate.c:67 (sofia/external/186******73@192.168.1.101) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  248. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  249. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:528 (sofia/external/186******73@192.168.1.101) State ROUTING going to sleep
  250. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:472 (sofia/external/186******73@192.168.1.101) Running State Change CS_CONSUME_MEDIA
  251. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:547 (sofia/external/186******73@192.168.1.101) State CONSUME_MEDIA
  252. 2017-04-14 14:45:58.552511 [DEBUG] switch_core_state_machine.c:547 (sofia/external/186******73@192.168.1.101) State CONSUME_MEDIA going to sleep
  253. recv 319 bytes from udp/[192.168.1.101]:5060 at 14:45:58.585924:
  254.    ------------------------------------------------------------------------
  255.    SIP/2.0 100 Trying
  256.    Via: SIP/2.0/UDP 192.168.1.246:5080;rport=5080;branch=z9hG4bKrSSavg44NcDQN
  257.    From: "Extension 8005" <sip:0000000000@192.168.1.246>;tag=SygvtFjSyD4Hg
  258.    To: <sip:186******73@192.168.1.101>
  259.    Call-ID: dbb3399b-9b80-1235-b997-000bab7a8683
  260.    CSeq: 105740115 INVITE
  261.    User-Agent: Gateway
  262.    Content-Length: 0
  263.    
  264.    ------------------------------------------------------------------------
  265. recv 630 bytes from udp/[192.168.1.101]:5060 at 14:46:01.560002:
  266.    ------------------------------------------------------------------------
  267.    SIP/2.0 200 OK
  268.    Via: SIP/2.0/UDP 192.168.1.246:5080;rport=5080;branch=z9hG4bKrSSavg44NcDQN
  269.    From: "Extension 8005" <sip:0000000000@192.168.1.246>;tag=SygvtFjSyD4Hg
  270.    To: <sip:186******73@192.168.1.101>;tag=3271950963
  271.    Call-ID: dbb3399b-9b80-1235-b997-000bab7a8683
  272.    CSeq: 105740115 INVITE
  273.    Contact: <sip:186******73@192.168.1.101:5060>
  274.    User-Agent: Gateway
  275.    Content-Type: application/sdp
  276.    Content-Length:   218
  277.    
  278.    v=0
  279.    o=- 65 66 IN IP4 192.168.1.101
  280.    s=Gateway
  281.    c=IN IP4 192.168.1.101
  282.    t=0 0
  283.    m=audio 50000 RTP/AVP 0 8 101
  284.    a=rtpmap:0 PCMU/8000
  285.    a=rtpmap:8 PCMA/8000
  286.    a=rtpmap:101 telephone-event/8000
  287.    a=fmtp:101 0-15
  288.    a=sendrecv
  289.    ------------------------------------------------------------------------
  290. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  291. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  292. 2017-04-14 14:46:01.552506 [DEBUG] sofia.c:6614 Channel sofia/external/186******73@192.168.1.101 entering state [completing][200]
  293. 2017-04-14 14:46:01.552506 [DEBUG] sofia.c:6624 Remote SDP:
  294. v=0
  295. o=- 65 66 IN IP4 192.168.1.101
  296. s=Gateway
  297. c=IN IP4 192.168.1.101
  298. t=0 0
  299. m=audio 50000 RTP/AVP 0 8 101
  300. a=rtpmap:0 PCMU/8000
  301. a=rtpmap:8 PCMA/8000
  302. a=rtpmap:101 telephone-event/8000
  303. a=fmtp:101 0-15
  304.  
  305. send 396 bytes to udp/[192.168.1.101]:5060 at 14:46:01.560851:
  306.    ------------------------------------------------------------------------
  307.    ACK sip:186******73@192.168.1.101:5060 SIP/2.0
  308.    Via: SIP/2.0/UDP 192.168.1.246:5080;rport;branch=z9hG4bKS2j3XBN8jN39g
  309.    Max-Forwards: 70
  310.    From: "Extension 8005" <sip:0000000000@192.168.1.246>;tag=SygvtFjSyD4Hg
  311.    To: <sip:186******73@192.168.1.101>;tag=3271950963
  312.    Call-ID: dbb3399b-9b80-1235-b997-000bab7a8683
  313.    CSeq: 105740115 ACK
  314.    Contact: <sip:mod_sofia@192.168.1.246:5080>
  315.    Content-Length: 0
  316.    
  317.    ------------------------------------------------------------------------
  318. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  319. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  320. 2017-04-14 14:46:01.552506 [DEBUG] sofia.c:6614 Channel sofia/external/186******73@192.168.1.101 entering state [ready][200]
  321. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  322. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3682 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  323. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  324. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  325. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  326. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3682 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  327. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3543 Set telephone-event payload to 101
  328. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:2473 Set Codec sofia/external/186******73@192.168.1.101 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  329. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_codec.c:111 sofia/external/186******73@192.168.1.101 Original read codec set to PCMU:0
  330. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3881 Set 2833 dtmf send payload to 101
  331. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:5141 AUDIO RTP [sofia/external/186******73@192.168.1.101] 192.168.1.246 port 29540 -> 192.168.1.101 port 50000 codec: 0 ms: 20
  332. 2017-04-14 14:46:01.552506 [DEBUG] switch_rtp.c:3548 Starting timer [soft] 160 bytes per 20ms
  333. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:5439 Set 2833 dtmf send payload to 101
  334. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:5445 Set 2833 dtmf receive payload to 101
  335. 2017-04-14 14:46:01.552506 [DEBUG] switch_channel.c:3635 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  336. 2017-04-14 14:46:01.552506 [NOTICE] sofia.c:7475 Channel [sofia/external/186******73@192.168.1.101] has been answered
  337. 2017-04-14 14:46:01.552506 [DEBUG] switch_channel.c:3689 (sofia/external/186******73@192.168.1.101) Callstate Change DOWN -> ACTIVE
  338. 2017-04-14 14:46:01.552506 [DEBUG] switch_ivr_originate.c:412 Setting codec string on sofia/internal/8005@127.0.0.1 to PCMU@8000h@20i
  339. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  340. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  341. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3682 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  342. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  343. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:2473 Set Codec sofia/internal/8005@127.0.0.1 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  344. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_codec.c:111 sofia/internal/8005@127.0.0.1 Original read codec set to PCMU:0
  345. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:3903 No 2833 in SDP.  Disable 2833 dtmf and switch to INFO
  346. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_media.c:5141 AUDIO RTP [sofia/internal/8005@127.0.0.1] 192.168.1.246 port 22532 -> 192.168.1.33 port 10000 codec: 0 ms: 20
  347. 2017-04-14 14:46:01.552506 [DEBUG] switch_rtp.c:3548 Starting timer [soft] 160 bytes per 20ms
  348. 2017-04-14 14:46:01.552506 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/8005@127.0.0.1!
  349. 2017-04-14 14:46:01.552506 [DEBUG] switch_channel.c:3399 (sofia/internal/8005@127.0.0.1) Callstate Change RINGING -> EARLY
  350. 2017-04-14 14:46:01.552506 [DEBUG] mod_sofia.c:780 Local SDP sofia/internal/8005@127.0.0.1:
  351. v=0
  352. o=FreeSWITCH 1492129829 1492129830 IN IP4 192.168.1.246
  353. s=FreeSWITCH
  354. c=IN IP4 192.168.1.246
  355. t=0 0
  356. m=audio 22532 RTP/AVP 0
  357. a=rtpmap:0 PCMU/8000
  358. a=ptime:20
  359. a=sendrecv
  360.  
  361. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_session.c:908 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  362. send 1071 bytes to udp/[192.168.1.33]:5060 at 14:46:01.566374:
  363.    ------------------------------------------------------------------------
  364. 2017-04-14 14:46:01.552506 [NOTICE] switch_ivr_originate.c:3522 Channel [sofia/internal/8005@127.0.0.1] has been answered
  365.    SIP/2.0 200 OK
  366.    Via: SIP/2.0/UDP 192.168.1.33:5060;branch=z9hG4bK19726;rport=5060
  367.    From: "8005" <sip:8005@127.0.0.1;user=phone>;tag=3cd16e0589b326696
  368.    To: <sip:9186******73@127.0.0.1;user=phone>;tag=28DF59255FZrQ
  369.    Call-ID: 3cd16e0589b39777@192.168.1.33
  370.    CSeq: 2082 INVITE
  371.    Contact: <sip:9186******73@117.185.49.89:5060;transport=udp>
  372.    User-Agent: FreeSWITCH-mod_sofia/1.5.15b+git~20141220T224621Z~0a0b9262b4~64bit
  373.    Accept: application/sdp
  374.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  375.    Supported: timer, path, replaces
  376.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  377.    Content-Type: application/sdp
  378.    Content-Disposition: session
  379.    Content-Length: 166
  380.    P-Asserted-Identity: "Outbound Call" <sip:186******73@127.0.0.1>
  381.    
  382.    v=0
  383.    o=FreeSWITCH 1492129829 1492129830 IN IP4 192.168.1.246
  384.    s=FreeSWITCH
  385.    c=IN IP4 192.168.1.246
  386.    t=0 0
  387.    m=audio 22532 RTP/AVP 0
  388.    a=rtpmap:0 PCMU/8000
  389.    a=ptime:20
  390.    ------------------------------------------------------------------------
  391. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  392. 2017-04-14 14:46:01.552506 [DEBUG] switch_channel.c:3689 (sofia/internal/8005@127.0.0.1) Callstate Change EARLY -> ACTIVE
  393. 2017-04-14 14:46:01.552506 [DEBUG] sofia.c:6614 Channel sofia/internal/8005@127.0.0.1 entering state [completed][200]
  394. 2017-04-14 14:46:01.552506 [DEBUG] switch_ivr_originate.c:3580 Originate Resulted in Success: [sofia/external/186******73@192.168.1.101]
  395. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_session.c:908 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  396. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_session.c:908 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  397. 2017-04-14 14:46:01.552506 [DEBUG] switch_ivr_bridge.c:1465 (sofia/external/186******73@192.168.1.101) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  398. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  399. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_state_machine.c:472 (sofia/external/186******73@192.168.1.101) Running State Change CS_EXCHANGE_MEDIA
  400. 2017-04-14 14:46:01.552506 [DEBUG] switch_core_state_machine.c:538 (sofia/external/186******73@192.168.1.101) State EXCHANGE_MEDIA
  401. 2017-04-14 14:46:01.552506 [DEBUG] mod_sofia.c:594 SOFIA EXCHANGE_MEDIA
  402. recv 376 bytes from udp/[192.168.1.33]:5060 at 14:46:01.576230:
  403.    ------------------------------------------------------------------------
  404.    ACK sip:9186******73@117.185.49.89:5060;transport=udp SIP/2.0
  405.    Via: SIP/2.0/UDP 192.168.1.33:5060;rport;branch=z9hG4bK27697;rport
  406.    From: "8005" <sip:8005@127.0.0.1;user=phone>;tag=3cd16e0589b326696
  407.    To: <sip:9186******73@127.0.0.1;user=phone>;tag=28DF59255FZrQ
  408.    Call-ID: 3cd16e0589b39777@192.168.1.33
  409.    CSeq: 2082 ACK
  410.    Max-Forwards: 70
  411.    User-Agent: SIPUA
  412.    Content-Length: 0
  413.    
  414.    ------------------------------------------------------------------------
  415. 2017-04-14 14:46:01.572513 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  416. 2017-04-14 14:46:01.572513 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  417. 2017-04-14 14:46:01.572513 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  418. 2017-04-14 14:46:01.592514 [DEBUG] sofia.c:6614 Channel sofia/internal/8005@127.0.0.1 entering state [ready][200]
  419. 2017-04-14 14:46:01.592514 [DEBUG] switch_core_session.c:970 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  420. 2017-04-14 14:46:01.592514 [DEBUG] switch_core_session.c:970 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  421. recv 414 bytes from udp/[192.168.1.101]:5060 at 14:46:06.867652:
  422.    ------------------------------------------------------------------------
  423.    BYE sip:mod_sofia@192.168.1.246:5080 SIP/2.0
  424.    Via: SIP/2.0/UDP 192.168.1.101:5060;branch=z9hG4bK3093601659;rport
  425.    From: <sip:186******73@192.168.1.101>;tag=3271950963
  426.    To: "Extension 8005" <sip:0000000000@192.168.1.246>;tag=SygvtFjSyD4Hg
  427.    Call-ID: dbb3399b-9b80-1235-b997-000bab7a8683
  428.    CSeq: 105740116 BYE
  429.    Contact: <sip:186******73@192.168.1.101:5060>
  430.    Max-Forwards: 70
  431.    User-Agent: Gateway
  432.    Content-Length: 0
  433.    
  434.    ------------------------------------------------------------------------
  435. 2017-04-14 14:46:06.852505 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  436. 2017-04-14 14:46:06.872505 [NOTICE] sofia.c:952 Hangup sofia/external/186******73@192.168.1.101 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  437. 2017-04-14 14:46:06.872505 [DEBUG] switch_channel.c:3222 Send signal sofia/external/186******73@192.168.1.101 [KILL]
  438. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  439. send 507 bytes to udp/[192.168.1.101]:5060 at 14:46:06.873375:
  440.    ------------------------------------------------------------------------
  441.    SIP/2.0 200 OK
  442.    Via: SIP/2.0/UDP 192.168.1.101:5060;branch=z9hG4bK3093601659;rport=5060
  443.    From: <sip:186******73@192.168.1.101>;tag=3271950963
  444.    To: "Extension 8005" <sip:0000000000@192.168.1.246>;tag=SygvtFjSyD4Hg
  445.    Call-ID: dbb3399b-9b80-1235-b997-000bab7a8683
  446.    CSeq: 105740116 BYE
  447.    User-Agent: FreeSWITCH-mod_sofia/1.5.15b+git~20141220T224621Z~0a0b9262b4~64bit
  448.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  449.    Supported: timer, path, replaces
  450.    Content-Length: 0
  451.    
  452.    ------------------------------------------------------------------------
  453. 2017-04-14 14:46:06.872505 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [sofia/external/186******73@192.168.1.101]
  454. 2017-04-14 14:46:06.872505 [DEBUG] switch_ivr_bridge.c:690 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  455. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:538 (sofia/external/186******73@192.168.1.101) State EXCHANGE_MEDIA going to sleep
  456. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:472 (sofia/external/186******73@192.168.1.101) Running State Change CS_HANGUP
  457. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:735 (sofia/external/186******73@192.168.1.101) Callstate Change ACTIVE -> HANGUP
  458. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:737 (sofia/external/186******73@192.168.1.101) State HANGUP
  459. 2017-04-14 14:46:06.872505 [DEBUG] mod_sofia.c:413 Channel sofia/external/186******73@192.168.1.101 hanging up, cause: NORMAL_CLEARING
  460. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:60 sofia/external/186******73@192.168.1.101 Standard HANGUP, cause: NORMAL_CLEARING
  461. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:737 (sofia/external/186******73@192.168.1.101) State HANGUP going to sleep
  462. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:504 (sofia/external/186******73@192.168.1.101) State Change CS_HANGUP -> CS_REPORTING
  463. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  464. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:472 (sofia/external/186******73@192.168.1.101) Running State Change CS_REPORTING
  465. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:823 (sofia/external/186******73@192.168.1.101) State REPORTING
  466. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:104 sofia/external/186******73@192.168.1.101 Standard REPORTING, cause: NORMAL_CLEARING
  467. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:823 (sofia/external/186******73@192.168.1.101) State REPORTING going to sleep
  468. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_state_machine.c:498 (sofia/external/186******73@192.168.1.101) State Change CS_REPORTING -> CS_DESTROY
  469. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  470. 2017-04-14 14:46:06.872505 [DEBUG] switch_core_session.c:1615 Session 204 (sofia/external/186******73@192.168.1.101) Locked, Waiting on external entities
  471. 2017-04-14 14:46:06.892515 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [sofia/internal/8005@127.0.0.1]
  472. 2017-04-14 14:46:06.892515 [DEBUG] switch_ivr_bridge.c:690 Send signal sofia/external/186******73@192.168.1.101 [BREAK]
  473. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_session.c:908 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  474. 2017-04-14 14:46:06.892515 [NOTICE] switch_core_session.c:1633 Session 204 (sofia/external/186******73@192.168.1.101) Ended
  475. 2017-04-14 14:46:06.892515 [NOTICE] switch_core_session.c:1637 Close Channel sofia/external/186******73@192.168.1.101 [CS_DESTROY]
  476. 2017-04-14 14:46:06.892515 [NOTICE] switch_core_state_machine.c:315 sofia/internal/8005@127.0.0.1 has executed the last dialplan instruction, hanging up.
  477. 2017-04-14 14:46:06.892515 [NOTICE] switch_core_state_machine.c:317 Hangup sofia/internal/8005@127.0.0.1 [CS_EXECUTE] [NORMAL_CLEARING]
  478. 2017-04-14 14:46:06.892515 [DEBUG] switch_channel.c:3222 Send signal sofia/internal/8005@127.0.0.1 [KILL]
  479. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  480. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/8005@127.0.0.1) State EXECUTE going to sleep
  481. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/8005@127.0.0.1) Running State Change CS_HANGUP
  482. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/8005@127.0.0.1) Callstate Change ACTIVE -> HANGUP
  483. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:626 (sofia/external/186******73@192.168.1.101) Running State Change CS_DESTROY
  484. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/8005@127.0.0.1) State HANGUP
  485. 2017-04-14 14:46:06.892515 [DEBUG] mod_sofia.c:407 sofia/internal/8005@127.0.0.1 Overriding SIP cause 480 with 200 from the other leg
  486. 2017-04-14 14:46:06.892515 [DEBUG] mod_sofia.c:413 Channel sofia/internal/8005@127.0.0.1 hanging up, cause: NORMAL_CLEARING
  487. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:636 (sofia/external/186******73@192.168.1.101) State DESTROY
  488. 2017-04-14 14:46:06.892515 [DEBUG] mod_sofia.c:323 sofia/external/186******73@192.168.1.101 SOFIA DESTROY
  489. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:111 sofia/external/186******73@192.168.1.101 Standard DESTROY
  490. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:636 (sofia/external/186******73@192.168.1.101) State DESTROY going to sleep
  491. 2017-04-14 14:46:06.892515 [DEBUG] mod_sofia.c:465 Sending BYE to sofia/internal/8005@127.0.0.1
  492. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:60 sofia/internal/8005@127.0.0.1 Standard HANGUP, cause: NORMAL_CLEARING
  493. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/8005@127.0.0.1) State HANGUP going to sleep
  494. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/8005@127.0.0.1) State Change CS_HANGUP -> CS_REPORTING
  495. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  496. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/8005@127.0.0.1) Running State Change CS_REPORTING
  497. send 608 bytes to udp/[192.168.1.33]:5060 at 14:46:06.894485:
  498.    ------------------------------------------------------------------------
  499.    BYE sip:8005@192.168.1.33:5060 SIP/2.0
  500.    Via: SIP/2.0/UDP 117.185.49.89;rport;branch=z9hG4bKmZcQ8DSKtpD0Q
  501.    Max-Forwards: 70
  502.    From: <sip:9186******73@127.0.0.1;user=phone>;tag=28DF59255FZrQ
  503.    To: "8005" <sip:8005@127.0.0.1;user=phone>;tag=3cd16e0589b326696
  504.    Call-ID: 3cd16e0589b39777@192.168.1.33
  505.    CSeq: 105740119 BYE
  506.    User-Agent: FreeSWITCH-mod_sofia/1.5.15b+git~20141220T224621Z~0a0b9262b4~64bit
  507.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  508.    Supported: timer, path, replaces
  509.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  510.    Content-Length: 0
  511.    
  512.    ------------------------------------------------------------------------
  513. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/8005@127.0.0.1) State REPORTING
  514. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:104 sofia/internal/8005@127.0.0.1 Standard REPORTING, cause: NORMAL_CLEARING
  515. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/8005@127.0.0.1) State REPORTING going to sleep
  516. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:498 (sofia/internal/8005@127.0.0.1) State Change CS_REPORTING -> CS_DESTROY
  517. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/8005@127.0.0.1 [BREAK]
  518. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_session.c:1615 Session 203 (sofia/internal/8005@127.0.0.1) Locked, Waiting on external entities
  519. 2017-04-14 14:46:06.892515 [NOTICE] switch_core_session.c:1633 Session 203 (sofia/internal/8005@127.0.0.1) Ended
  520. 2017-04-14 14:46:06.892515 [NOTICE] switch_core_session.c:1637 Close Channel sofia/internal/8005@127.0.0.1 [CS_DESTROY]
  521. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:626 (sofia/internal/8005@127.0.0.1) Running State Change CS_DESTROY
  522. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/8005@127.0.0.1) State DESTROY
  523. 2017-04-14 14:46:06.892515 [DEBUG] mod_sofia.c:323 sofia/internal/8005@127.0.0.1 SOFIA DESTROY
  524. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:111 sofia/internal/8005@127.0.0.1 Standard DESTROY
  525. 2017-04-14 14:46:06.892515 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/8005@127.0.0.1) State DESTROY going to sleep
  526. recv 369 bytes from udp/[192.168.1.33]:5060 at 14:46:06.906296:
  527.    ------------------------------------------------------------------------
  528.    SIP/2.0 200 OK
  529.    Via: SIP/2.0/UDP 117.185.49.89;rport=5060;branch=z9hG4bKmZcQ8DSKtpD0Q;received=192.168.1.246
  530.    From: <sip:9186******73@127.0.0.1;user=phone>;tag=28DF59255FZrQ
  531.    To: "8005" <sip:8005@127.0.0.1;user=phone>;tag=3cd16e0589b326696
  532.    Call-ID: 3cd16e0589b39777@192.168.1.33
  533.    CSeq: 105740119 BYE
  534.    Contact: "8005" <sip:8005@192.168.1.33:5060>
  535.    Content-Length: 0
  536.    
  537.    ------------------------------------------------------------------------
  538.  
  539.  

Replies to 通过网关外拨, FS没有发送RTP(trace日志) rss

Title Name Language When
Re: 通过网关外拨, FS没有发送RTP(trace日志) lzpong text 7 Years ago.

Reply to "通过网关外拨, FS没有发送RTP(trace日志)"