FreeSWITCH Pastebin

Untitled

From Joshua Young, 7 Years ago, written in Plain Text.
- go back
URL https://pastebin.freeswitch.org/view/ead4dbd9
Embed
Viewing differences between and Untitled
  1. recv 1170 bytes from udp/[192.168.1.213]:5060 at 13:04:39.625053:
  2.    ------------------------------------------------------------------------
  3.    INVITE sip:1001@192.168.1.8;user=phone SIP/2.0
  4.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bK6c2566145af522c0
  5.    From: <sip:1010@192.168.1.8;user=phone>;tag=7d630af1cba71ad7
  6.    To: <sip:1001@192.168.1.8;user=phone>
  7.    Contact: <sip:1010@192.168.1.213:5060;transport=udp;user=phone>
  8.    Supported: replaces, timer, path
  9.    Call-ID: f2a3928138c1ad37e315f04189f38bc0@192.168.1.213
  10.    CSeq: 25360 INVITE
  11.    User-Agent: Grandstream GXV3000 1.2.3.7
  12.    Max-Forwards: 70
  13.    Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK,MESSAGE
  14.    Content-Type: application/sdp
  15.    Content-Length: 577
  16.  
  17.    v=0
  18.    o=1010 8000 8000 IN IP4 192.168.1.213
  19.    s=SIP Call
  20.    c=IN IP4 192.168.1.213
  21.    t=0 0
  22.    m=audio 5004 RTP/AVP 0 8 4 18 3 2
  23.    a=sendrecv
  24.    a=rtpmap:0 PCMU/8000
  25.    a=rtpmap:8 PCMA/8000
  26.    a=rtpmap:4 G723/8000
  27.    a=rtpmap:18 G729/8000
  28.    a=rtpmap:3 GSM/8000
  29.    a=rtpmap:2 G726-32/8000
  30.    a=ptime:20
  31.    m=video 5006 RTP/AVP 99 34 103
  32.    a=sendrecv
  33.    a=rtpmap:99 H264/90000
  34.    a=fmtp:99 profile-level-id=428014; packetization-mode=0; sprop-parameter-sets=Z0KADJWgUH5A,aM4Ecs==
  35.    a=rtpmap:34 H263/90000
  36.    a=fmtp:34 CIF=2 MaxBR=1280
  37.    a=rtpmap:103 H263-1998/90000
  38.    a=fmtp:103 CIF=2 MaxBR=1280
  39.    a=framerate:15
  40.    ------------------------------------------------------------------------
  41. send 345 bytes to udp/[192.168.1.213]:5060 at 13:04:39.625365:
  42.    ------------------------------------------------------------------------
  43.    SIP/2.0 100 Trying
  44.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bK6c2566145af522c0
  45.    From: <sip:1010@192.168.1.8;user=phone>;tag=7d630af1cba71ad7
  46.    To: <sip:1001@192.168.1.8;user=phone>
  47.    Call-ID: f2a3928138c1ad37e315f04189f38bc0@192.168.1.213
  48.    CSeq: 25360 INVITE
  49.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  50.    Content-Length: 0
  51.  
  52.    ------------------------------------------------------------------------
  53. 2017-05-09 13:04:39.616739 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1010@192.168.1.8 [6be6ea44-2eaa-404a-9660-0c97dd983810]
  54. 2017-05-09 13:04:39.616739 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1010@192.168.1.8) Running State Change CS_NEW (Cur 1 Tot 119)
  55. 2017-05-09 13:04:39.616739 [DEBUG] sofia.c:9834 sofia/internal/1010@192.168.1.8 receiving invite from 192.168.1.213:5060 version: 1.6.17 -34-0fc0946 64bit
  56. 2017-05-09 13:04:39.616739 [DEBUG] sofia.c:10005 IP 192.168.1.213 Rejected by acl "domains". Falling back to Digest auth.
  57. send 847 bytes to udp/[192.168.1.213]:5060 at 13:04:39.626727:
  58.    ------------------------------------------------------------------------
  59.    SIP/2.0 407 Proxy Authentication Required
  60.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bK6c2566145af522c0
  61.    From: <sip:1010@192.168.1.8;user=phone>;tag=7d630af1cba71ad7
  62.    To: <sip:1001@192.168.1.8;user=phone>;tag=yKQ35jjH279Nj
  63.    Call-ID: f2a3928138c1ad37e315f04189f38bc0@192.168.1.213
  64.    CSeq: 25360 INVITE
  65.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  66.    Accept: application/sdp
  67.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  68.    Supported: timer, path, replaces
  69.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  70.    Proxy-Authenticate: Digest realm="192.168.1.8", nonce="54de1791-49ce-48ec-8578-4a0c28cfddf5", algorithm=MD5, qop="auth"
  71.    Content-Length: 0
  72.  
  73.    ------------------------------------------------------------------------
  74. 2017-05-09 13:04:39.626905 [DEBUG] sofia.c:2334 detaching session 6be6ea44-2eaa-404a-9660-0c97dd983810
  75. 2017-05-09 13:04:39.626905 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/1010@192.168.1.8) State NEW
  76. recv 538 bytes from udp/[192.168.1.213]:5060 at 13:04:39.630002:
  77.    ------------------------------------------------------------------------
  78.    ACK sip:1001@192.168.1.8;user=phone SIP/2.0
  79.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bK6c2566145af522c0
  80.    From: <sip:1010@192.168.1.8;user=phone>;tag=7d630af1cba71ad7
  81.    To: <sip:1001@192.168.1.8;user=phone>;tag=yKQ35jjH279Nj
  82.    Contact: <sip:1010@192.168.1.213:5060;transport=udp;user=phone>
  83.    Call-ID: f2a3928138c1ad37e315f04189f38bc0@192.168.1.213
  84.    CSeq: 25360 ACK
  85.    User-Agent: Grandstream GXV3000 1.2.3.7
  86.    Max-Forwards: 70
  87.    Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK,MESSAGE
  88.    Content-Length: 0
  89.  
  90.    ------------------------------------------------------------------------
  91. recv 1431 bytes from udp/[192.168.1.213]:5060 at 13:04:39.631705:
  92.    ------------------------------------------------------------------------
  93.    INVITE sip:1001@192.168.1.8;user=phone SIP/2.0
  94.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bK1b138f55697708d3
  95.    From: <sip:1010@192.168.1.8;user=phone>;tag=7d630af1cba71ad7
  96.    To: <sip:1001@192.168.1.8;user=phone>
  97.    Contact: <sip:1010@192.168.1.213:5060;transport=udp;user=phone>
  98.    Supported: replaces, timer, path
  99.    Proxy-Authorization: Digest username="1010", realm="192.168.1.8", algorithm=MD5, uri="sip:1001@192.168.1.8;user=phone", qop=auth, nc=00000001, cnonce="2fd39a1149414526", nonce="54de1791-49ce-48ec-8578-4a0c28cfddf5", response="40a4b0f5a444192dd10241f39b8d9aa4"
  100.    Call-ID: f2a3928138c1ad37e315f04189f38bc0@192.168.1.213
  101.    CSeq: 25361 INVITE
  102.    User-Agent: Grandstream GXV3000 1.2.3.7
  103.    Max-Forwards: 70
  104.    Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK,MESSAGE
  105.    Content-Type: application/sdp
  106.    Content-Length: 577
  107.  
  108.    v=0
  109.    o=1010 8000 8001 IN IP4 192.168.1.213
  110.    s=SIP Call
  111.    c=IN IP4 192.168.1.213
  112.    t=0 0
  113.    m=audio 5004 RTP/AVP 0 8 4 18 3 2
  114.    a=sendrecv
  115.    a=rtpmap:0 PCMU/8000
  116.    a=rtpmap:8 PCMA/8000
  117.    a=rtpmap:4 G723/8000
  118.    a=rtpmap:18 G729/8000
  119.    a=rtpmap:3 GSM/8000
  120.    a=rtpmap:2 G726-32/8000
  121.    a=ptime:20
  122.    m=video 5006 RTP/AVP 99 34 103
  123.    a=sendrecv
  124.    a=rtpmap:99 H264/90000
  125.    a=fmtp:99 profile-level-id=428014; packetization-mode=0; sprop-parameter-sets=Z0KADJWgUH5A,aM4Ecs==
  126.    a=rtpmap:34 H263/90000
  127.    a=fmtp:34 CIF=2 MaxBR=1280
  128.    a=rtpmap:103 H263-1998/90000
  129.    a=fmtp:103 CIF=2 MaxBR=1280
  130.    a=framerate:15
  131.    ------------------------------------------------------------------------
  132. send 345 bytes to udp/[192.168.1.213]:5060 at 13:04:39.631901:
  133.    ------------------------------------------------------------------------
  134.    SIP/2.0 100 Trying
  135.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bK1b138f55697708d3
  136.    From: <sip:1010@192.168.1.8;user=phone>;tag=7d630af1cba71ad7
  137.    To: <sip:1001@192.168.1.8;user=phone>
  138.    Call-ID: f2a3928138c1ad37e315f04189f38bc0@192.168.1.213
  139.    CSeq: 25361 INVITE
  140.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  141.    Content-Length: 0
  142.  
  143.    ------------------------------------------------------------------------
  144. 2017-05-09 13:04:39.626905 [DEBUG] sofia.c:2442 Re-attaching to session 6be6ea44-2eaa-404a-9660-0c97dd983810
  145. 2017-05-09 13:04:39.646835 [DEBUG] sofia.c:9834 sofia/internal/1010@192.168.1.8 receiving invite from 192.168.1.213:5060 version: 1.6.17 -34-0fc0946 64bit
  146. 2017-05-09 13:04:39.646835 [DEBUG] sofia.c:10005 IP 192.168.1.213 Rejected by acl "domains". Falling back to Digest auth.
  147. 2017-05-09 13:04:39.646835 [DEBUG] sofia.c:7048 Channel sofia/internal/1010@192.168.1.8 entering state [received][100]
  148. 2017-05-09 13:04:39.646835 [DEBUG] sofia.c:7058 Remote SDP:
  149. v=0
  150. o=1010 8000 8001 IN IP4 192.168.1.213
  151. s=SIP Call
  152. c=IN IP4 192.168.1.213
  153. t=0 0
  154. m=audio 5004 RTP/AVP 0 8 4 18 3 2
  155. a=rtpmap:0 PCMU/8000
  156. a=rtpmap:8 PCMA/8000
  157. a=rtpmap:4 G723/8000
  158. a=rtpmap:18 G729/8000
  159. a=rtpmap:3 GSM/8000
  160. a=rtpmap:2 G726-32/8000
  161. a=ptime:20
  162. m=video 5006 RTP/AVP 99 34 103
  163. a=rtpmap:99 H264/90000
  164. a=fmtp:99 profile-level-id=428014; packetization-mode=0; sprop-parameter-sets=Z0KADJWgUH5A,aM4Ecs==
  165. a=rtpmap:34 H263/90000
  166. a=fmtp:34 CIF=2 MaxBR=1280
  167. a=rtpmap:103 H263-1998/90000
  168. a=fmtp:103 CIF=2 MaxBR=1280
  169. a=framerate:15
  170.  
  171. 2017-05-09 13:04:39.646835 [DEBUG] sofia.c:7450 (sofia/internal/1010@192.168.1.8) State Change CS_NEW -> CS_INIT
  172. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1010@192.168.1.8) Running State Change CS_INIT (Cur 1 Tot 119)
  173. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1010@192.168.1.8) State INIT
  174. 2017-05-09 13:04:39.646835 [DEBUG] mod_sofia.c:90 sofia/internal/1010@192.168.1.8 SOFIA INIT
  175. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1010@192.168.1.8 Standard INIT
  176. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1010@192.168.1.8) State Change CS_INIT -> CS_ROUTING
  177. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1010@192.168.1.8) State INIT going to sleep
  178. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1010@192.168.1.8) Running State Change CS_ROUTING (Cur 1 Tot 119)
  179. 2017-05-09 13:04:39.646835 [DEBUG] switch_channel.c:2249 (sofia/internal/1010@192.168.1.8) Callstate Change DOWN -> RINGING
  180. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1010@192.168.1.8) State ROUTING
  181. 2017-05-09 13:04:39.646835 [DEBUG] mod_sofia.c:143 sofia/internal/1010@192.168.1.8 SOFIA ROUTING
  182. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:236 sofia/internal/1010@192.168.1.8 Standard ROUTING
  183. 2017-05-09 13:04:39.646835 [INFO] mod_dialplan_xml.c:637 Processing 1010 <1010>->1001 in context default
  184. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->unloop] continue=false
  185. Dialplan: sofia/internal/1010@192.168.1.8 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  186. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  187. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->tod_example] continue=true
  188. Dialplan: sofia/internal/1010@192.168.1.8 Date/Time Match (PASS) [tod_example] break=on-false
  189. Dialplan: sofia/internal/1010@192.168.1.8 Action set(open=true)
  190. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->holiday_example] continue=true
  191. Dialplan: sofia/internal/1010@192.168.1.8 Date/TimeMatch (FAIL) [holiday_example] break=on-false
  192. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->global-intercept] continue=false
  193. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [global-intercept] destination_number(1001) =~ /^886$/ break=on-false
  194. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->group-intercept] continue=false
  195. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [group-intercept] destination_number(1001) =~ /^\*8$/ break=on-false
  196. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->intercept-ext] continue=false
  197. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [intercept-ext] destination_number(1001) =~ /^\*\*(\d+)$/ break=on-false
  198. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->redial] continue=false
  199. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [redial] destination_number(1001) =~ /^(redial|870)$/ break=on-false
  200. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->global] continue=true
  201. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
  202. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [global] ${default_password}(12345) =~ /^1234$/ break=never
  203. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never
  204. Dialplan: sofia/internal/1010@192.168.1.8 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
  205. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [global] ${switch_r_sdp}(v=0
  206. o=1010 8000 8001 IN IP4 192.168.1.213
  207. s=SIP Call
  208. c=IN IP4 192.168.1.213
  209. t=0 0
  210. m=audio 5004 RTP/AVP 0 8 4 18 3 2
  211. a=rtpmap:0 PCMU/8000
  212. a=rtpmap:8 PCMA/8000
  213. a=rtpmap:4 G723/8000
  214. a=rtpmap:18 G729/8000
  215. a=rtpmap:3 GSM/8000
  216. a=rtpmap:2 G726-32/8000
  217. a=ptime:20
  218. m=video 5006 RTP/AVP 99 34 103
  219. a=rtpmap:99 H264/90000
  220. a=fmtp:99 profile-level-id=428014; packetization-mode=0; sprop-parameter-sets=Z0KADJWgUH5A,aM4Ecs==
  221. a=rtpmap:34 H263/90000
  222. a=fmtp:34 CIF=2 MaxBR=1280
  223. a=rtpmap:103 H263-1998/90000
  224. a=fmtp:103 CIF=2 MaxBR=1280
  225. a=framerate:15
  226. ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
  227. Dialplan: sofia/internal/1010@192.168.1.8 Absolute Condition [global]
  228. Dialplan: sofia/internal/1010@192.168.1.8 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
  229. Dialplan: sofia/internal/1010@192.168.1.8 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  230. Dialplan: sofia/internal/1010@192.168.1.8 Action hash(insert/${domain_name}-last_dial/global/${uuid})
  231. Dialplan: sofia/internal/1010@192.168.1.8 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  232. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->snom-demo-2] continue=false
  233. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [snom-demo-2] destination_number(1001) =~ /^9001$/ break=on-false
  234. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->snom-demo-1] continue=false
  235. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [snom-demo-1] destination_number(1001) =~ /^9000$/ break=on-false
  236. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->eavesdrop] continue=false
  237. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
  238. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->eavesdrop] continue=false
  239. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^779$/ break=on-false
  240. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->call_return] continue=false
  241. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [call_return] destination_number(1001) =~ /^\*69$|^869$|^lcr$/ break=on-false
  242. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->del-group] continue=false
  243. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [del-group] destination_number(1001) =~ /^80(\d{2})$/ break=on-false
  244. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->add-group] continue=false
  245. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [add-group] destination_number(1001) =~ /^81(\d{2})$/ break=on-false
  246. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->call-group-simo] continue=false
  247. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [call-group-simo] destination_number(1001) =~ /^82(\d{2})$/ break=on-false
  248. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->call-group-order] continue=false
  249. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [call-group-order] destination_number(1001) =~ /^83(\d{2})$/ break=on-false
  250. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->extension-intercom] continue=false
  251. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [extension-intercom] destination_number(1001) =~ /^8(10[01][0-9])$/ break=on-false
  252. Dialplan: sofia/internal/1010@192.168.1.8 parsing [default->Local_Extension] continue=false
  253. Dialplan: sofia/internal/1010@192.168.1.8 Regex (PASS) [Local_Extension] destination_number(1001) =~ /^(10[01][0-9])$/ break=on-false
  254. Dialplan: sofia/internal/1010@192.168.1.8 Action export(dialed_extension=1001)
  255. Dialplan: sofia/internal/1010@192.168.1.8 Action bind_meta_app(1 b s execute_extension::dx XML features)
  256. Dialplan: sofia/internal/1010@192.168.1.8 Action bind_meta_app(2 b s record_session::/var/lib/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav)
  257. Dialplan: sofia/internal/1010@192.168.1.8 Action bind_meta_app(3 b s execute_extension::cf XML features)
  258. Dialplan: sofia/internal/1010@192.168.1.8 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
  259. Dialplan: sofia/internal/1010@192.168.1.8 Action set(ringback=${us-ring})
  260. Dialplan: sofia/internal/1010@192.168.1.8 Action set(transfer_ringback=local_stream://moh)
  261. Dialplan: sofia/internal/1010@192.168.1.8 Action set(call_timeout=30)
  262. Dialplan: sofia/internal/1010@192.168.1.8 Action set(hangup_after_bridge=true)
  263. Dialplan: sofia/internal/1010@192.168.1.8 Action set(continue_on_fail=true)
  264. Dialplan: sofia/internal/1010@192.168.1.8 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
  265. Dialplan: sofia/internal/1010@192.168.1.8 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
  266. Dialplan: sofia/internal/1010@192.168.1.8 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)})
  267. Dialplan: sofia/internal/1010@192.168.1.8 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid})
  268. Dialplan: sofia/internal/1010@192.168.1.8 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid})
  269. Dialplan: sofia/internal/1010@192.168.1.8 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid})
  270. Dialplan: sofia/internal/1010@192.168.1.8 Action bridge(user/${dialed_extension}@${domain_name})
  271. Dialplan: sofia/internal/1010@192.168.1.8 Action answer()
  272. Dialplan: sofia/internal/1010@192.168.1.8 Action sleep(1000)
  273. Dialplan: sofia/internal/1010@192.168.1.8 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension})
  274. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/1010@192.168.1.8) State Change CS_ROUTING -> CS_EXECUTE
  275. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1010@192.168.1.8) State ROUTING going to sleep
  276. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1010@192.168.1.8) Running State Change CS_EXECUTE (Cur 1 Tot 119)
  277. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1010@192.168.1.8) State EXECUTE
  278. 2017-05-09 13:04:39.646835 [DEBUG] mod_sofia.c:198 sofia/internal/1010@192.168.1.8 SOFIA EXECUTE
  279. 2017-05-09 13:04:39.646835 [DEBUG] switch_core_state_machine.c:328 sofia/internal/1010@192.168.1.8 Standard EXECUTE
  280. EXECUTE sofia/internal/1010@192.168.1.8 set(open=true)
  281. 2017-05-09 13:04:39.646835 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1010@192.168.1.8 [open]=[true]
  282. EXECUTE sofia/internal/1010@192.168.1.8 hash(insert/192.168.1.8-spymap/1010/6be6ea44-2eaa-404a-9660-0c97dd983810)
  283. EXECUTE sofia/internal/1010@192.168.1.8 hash(insert/192.168.1.8-last_dial/1010/1001)
  284. EXECUTE sofia/internal/1010@192.168.1.8 hash(insert/192.168.1.8-last_dial/global/6be6ea44-2eaa-404a-9660-0c97dd983810)
  285. EXECUTE sofia/internal/1010@192.168.1.8 export(RFC2822_DATE=Tue, 09 May 2017 13:04:39 -0400)
  286. 2017-05-09 13:04:39.646835 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Tue, 09 May 2017 13:04:39 -0400]
  287. EXECUTE sofia/internal/1010@192.168.1.8 export(dialed_extension=1001)
  288. 2017-05-09 13:04:39.646835 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [dialed_extension]=[1001]
  289. EXECUTE sofia/internal/1010@192.168.1.8 bind_meta_app(1 b s execute_extension::dx XML features)
  290. 2017-05-09 13:04:39.646835 [INFO] switch_ivr_async.c:4171 Bound B-Leg: *1 execute_extension::dx XML features
  291. EXECUTE sofia/internal/1010@192.168.1.8 bind_meta_app(2 b s record_session::/var/lib/freeswitch/recordings/1010.2017-05-09-13-04-39.wav)
  292. 2017-05-09 13:04:39.646835 [INFO] switch_ivr_async.c:4171 Bound B-Leg: *2 record_session::/var/lib/freeswitch/recordings/1010.2017-05-09-13-04-39.wav
  293. EXECUTE sofia/internal/1010@192.168.1.8 bind_meta_app(3 b s execute_extension::cf XML features)
  294. 2017-05-09 13:04:39.646835 [INFO] switch_ivr_async.c:4171 Bound B-Leg: *3 execute_extension::cf XML features
  295. EXECUTE sofia/internal/1010@192.168.1.8 bind_meta_app(4 b s execute_extension::att_xfer XML features)
  296. 2017-05-09 13:04:39.646835 [INFO] switch_ivr_async.c:4171 Bound B-Leg: *4 execute_extension::att_xfer XML features
  297. EXECUTE sofia/internal/1010@192.168.1.8 set(ringback=%(2000,4000,440,480))
  298. 2017-05-09 13:04:39.646835 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1010@192.168.1.8 [ringback]=[%(2000,4000,440,480)]
  299. EXECUTE sofia/internal/1010@192.168.1.8 set(transfer_ringback=local_stream://moh)
  300. 2017-05-09 13:04:39.646835 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1010@192.168.1.8 [transfer_ringback]=[local_stream://moh]
  301. EXECUTE sofia/internal/1010@192.168.1.8 set(call_timeout=30)
  302. 2017-05-09 13:04:39.646835 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1010@192.168.1.8 [call_timeout]=[30]
  303. EXECUTE sofia/internal/1010@192.168.1.8 set(hangup_after_bridge=true)
  304. 2017-05-09 13:04:39.646835 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1010@192.168.1.8 [hangup_after_bridge]=[true]
  305. EXECUTE sofia/internal/1010@192.168.1.8 set(continue_on_fail=true)
  306. 2017-05-09 13:04:39.646835 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1010@192.168.1.8 [continue_on_fail]=[true]
  307. EXECUTE sofia/internal/1010@192.168.1.8 hash(insert/192.168.1.8-call_return/1001/1010)
  308. EXECUTE sofia/internal/1010@192.168.1.8 hash(insert/192.168.1.8-last_dial_ext/1001/6be6ea44-2eaa-404a-9660-0c97dd983810)
  309. EXECUTE sofia/internal/1010@192.168.1.8 set(called_party_callgroup=techsupport)
  310. 2017-05-09 13:04:39.646835 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1010@192.168.1.8 [called_party_callgroup]=[techsupport]
  311. EXECUTE sofia/internal/1010@192.168.1.8 hash(insert/192.168.1.8-last_dial_ext/techsupport/6be6ea44-2eaa-404a-9660-0c97dd983810)
  312. EXECUTE sofia/internal/1010@192.168.1.8 hash(insert/192.168.1.8-last_dial_ext/global/6be6ea44-2eaa-404a-9660-0c97dd983810)
  313. EXECUTE sofia/internal/1010@192.168.1.8 hash(insert/192.168.1.8-last_dial/techsupport/6be6ea44-2eaa-404a-9660-0c97dd983810)
  314. EXECUTE sofia/internal/1010@192.168.1.8 bridge(user/1001@192.168.1.8)
  315. 2017-05-09 13:04:39.646835 [DEBUG] switch_channel.c:1250 sofia/internal/1010@192.168.1.8 EXPORTING[export_vars] [RFC2822_DATE]=[Tue, 09 May 2017 13:04:39 -0400] to event
  316. 2017-05-09 13:04:39.646835 [DEBUG] switch_channel.c:1250 sofia/internal/1010@192.168.1.8 EXPORTING[export_vars] [dialed_extension]=[1001] to event
  317. 2017-05-09 13:04:39.646835 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  318. 2017-05-09 13:04:39.646835 [DEBUG] switch_channel.c:1250 sofia/internal/1010@192.168.1.8 EXPORTING[export_vars] [RFC2822_DATE]=[Tue, 09 May 2017 13:04:39 -0400] to event
  319. 2017-05-09 13:04:39.646835 [DEBUG] switch_channel.c:1250 sofia/internal/1010@192.168.1.8 EXPORTING[export_vars] [dialed_extension]=[1001] to event
  320. 2017-05-09 13:04:39.646835 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  321. 2017-05-09 13:04:39.646835 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1001@192.168.1.161:5060 [83e9ac5f-3b6a-4c8f-9535-1f40b7173561]
  322. 2017-05-09 13:04:39.646835 [DEBUG] mod_sofia.c:4818 (sofia/internal/1001@192.168.1.161:5060) State Change CS_NEW -> CS_INIT
  323. 2017-05-09 13:04:39.646835 [NOTICE] switch_ivr_originate.c:2845 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  324. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1001@192.168.1.161:5060) Running State Change CS_INIT (Cur 2 Tot 120)
  325. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1001@192.168.1.161:5060) State INIT
  326. 2017-05-09 13:04:39.656885 [DEBUG] mod_sofia.c:90 sofia/internal/1001@192.168.1.161:5060 SOFIA INIT
  327. 2017-05-09 13:04:39.656885 [DEBUG] sofia_glue.c:1295 sofia/internal/1001@192.168.1.161:5060 sending invite version: 1.6.17 -34-0fc0946 64bit
  328. Local SDP:
  329. v=0
  330. o=FreeSWITCH 1494318985 1494318986 IN IP4 192.168.1.8
  331. s=FreeSWITCH
  332. c=IN IP4 192.168.1.8
  333. t=0 0
  334. m=audio 30494 RTP/AVP 0 8 102 9 101 106
  335. a=rtpmap:0 PCMU/8000
  336. a=rtpmap:8 PCMA/8000
  337. a=rtpmap:102 opus/48000/2
  338. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
  339. a=rtpmap:9 G722/8000
  340. a=rtpmap:101 telephone-event/8000
  341. a=fmtp:101 0-16
  342. a=rtpmap:106 telephone-event/48000
  343. a=fmtp:106 0-16
  344. a=ptime:20
  345. a=sendrecv
  346. m=video 25960 RTP/AVP 103 34 104 105
  347. b=AS:1024
  348. a=rtpmap:103 H264/90000
  349. a=rtpmap:34 H263/90000
  350. a=rtpmap:104 VP8/90000
  351. a=rtpmap:105 H264/90000
  352. a=rtcp-fb:103 ccm fir
  353. a=rtcp-fb:103 ccm tmmbr
  354. a=rtcp-fb:103 nack
  355. a=rtcp-fb:103 nack pli
  356. a=rtcp-fb:34 ccm fir
  357. a=rtcp-fb:34 ccm tmmbr
  358. a=rtcp-fb:34 nack
  359. a=rtcp-fb:34 nack pli
  360. a=rtcp-fb:104 ccm fir
  361. a=rtcp-fb:104 ccm tmmbr
  362. a=rtcp-fb:104 nack
  363. a=rtcp-fb:104 nack pli
  364. a=rtcp-fb:105 ccm fir
  365. a=rtcp-fb:105 ccm tmmbr
  366. a=rtcp-fb:105 nack
  367. a=rtcp-fb:105 nack pli
  368.  
  369. send 1958 bytes to udp/[192.168.1.161]:5060 at 13:04:39.658236:
  370.    ------------------------------------------------------------------------
  371.    INVITE sip:1001@192.168.1.161:5060;transport=udp;user=phone SIP/2.0
  372.    Via: SIP/2.0/UDP 192.168.1.8;rport;branch=z9hG4bKQZtX9pSBBtXFg
  373.    Max-Forwards: 69
  374.    From: "Extension 1010" <sip:1010@192.168.1.8>;tag=059m98KrvSpUS
  375.    To: <sip:1001@192.168.1.161:5060;transport=udp;user=phone>
  376.    Call-ID: 6ded1894-af7c-1235-51a3-080027de30fb
  377.    CSeq: 106838675 INVITE
  378.    Contact: <sip:mod_sofia@192.168.1.8:5060>
  379.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  380.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  381.    Supported: timer, path, replaces
  382.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  383.    Content-Type: application/sdp
  384.    Content-Disposition: session
  385.    Content-Length: 976
  386.    X-FS-Support: update_display,send_info
  387.    Remote-Party-ID: "Extension 1010" <sip:1010@192.168.1.8>;party=calling;screen=yes;privacy=off
  388.  
  389.    v=0
  390.    o=FreeSWITCH 1494318985 1494318986 IN IP4 192.168.1.8
  391.    s=FreeSWITCH
  392.    c=IN IP4 192.168.1.8
  393.    t=0 0
  394.    m=audio 30494 RTP/AVP 0 8 102 9 101 106
  395.    a=rtpmap:0 PCMU/8000
  396.    a=rtpmap:8 PCMA/8000
  397.    a=rtpmap:102 opus/48000/2
  398.    a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
  399.    a=rtpmap:9 G722/8000
  400.    a=rtpmap:101 telephone-event/8000
  401.    a=fmtp:101 0-16
  402.    a=rtpmap:106 telephone-event/48000
  403.    a=fmtp:106 0-16
  404.    a=ptime:20
  405.    m=video 25960 RTP/AVP 103 34 104 105
  406.    b=AS:1024
  407.    a=rtpmap:103 H264/90000
  408.    a=rtpmap:34 H263/90000
  409.    a=rtpmap:104 VP8/90000
  410.    a=rtpmap:105 H264/90000
  411.    a=rtcp-fb:103 ccm fir
  412.    a=rtcp-fb:103 ccm tmmbr
  413.    a=rtcp-fb:103 nack
  414.    a=rtcp-fb:103 nack pli
  415.    a=rtcp-fb:34 ccm fir
  416.    a=rtcp-fb:34 ccm tmmbr
  417.    a=rtcp-fb:34 nack
  418.    a=rtcp-fb:34 nack pli
  419.    a=rtcp-fb:104 ccm fir
  420.    a=rtcp-fb:104 ccm tmmbr
  421.    a=rtcp-fb:104 nack
  422.    a=rtcp-fb:104 nack pli
  423.    a=rtcp-fb:105 ccm fir
  424.    a=rtcp-fb:105 ccm tmmbr
  425.    a=rtcp-fb:105 nack
  426.    a=rtcp-fb:105 nack pli
  427.    ------------------------------------------------------------------------
  428. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1001@192.168.1.161:5060 Standard INIT
  429. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1001@192.168.1.161:5060) State Change CS_INIT -> CS_ROUTING
  430. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1001@192.168.1.161:5060) State INIT going to sleep
  431. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1001@192.168.1.161:5060) Running State Change CS_ROUTING (Cur 2 Tot 120)
  432. 2017-05-09 13:04:39.656885 [DEBUG] sofia.c:7048 Channel sofia/internal/1001@192.168.1.161:5060 entering state [calling][0]
  433. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1001@192.168.1.161:5060) State ROUTING
  434. 2017-05-09 13:04:39.656885 [DEBUG] mod_sofia.c:143 sofia/internal/1001@192.168.1.161:5060 SOFIA ROUTING
  435. 2017-05-09 13:04:39.656885 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/1001@192.168.1.161:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  436. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1001@192.168.1.161:5060) State ROUTING going to sleep
  437. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1001@192.168.1.161:5060) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 120)
  438. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1001@192.168.1.161:5060) State CONSUME_MEDIA
  439. 2017-05-09 13:04:39.656885 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1001@192.168.1.161:5060) State CONSUME_MEDIA going to sleep
  440. recv 342 bytes from udp/[192.168.1.161]:5060 at 13:04:39.661971:
  441.    ------------------------------------------------------------------------
  442.    SIP/2.0 100 Trying
  443.    Via: SIP/2.0/UDP 192.168.1.8;rport;branch=z9hG4bKQZtX9pSBBtXFg
  444.    From: "Extension 1010" <sip:1010@192.168.1.8>;tag=059m98KrvSpUS
  445.    To: <sip:1001@192.168.1.161:5060;transport=udp;user=phone>
  446.    Call-ID: 6ded1894-af7c-1235-51a3-080027de30fb
  447.    CSeq: 106838675 INVITE
  448.    User-Agent: Grandstream GXV3000 1.2.3.7
  449.    Content-Length: 0
  450.  
  451.    ------------------------------------------------------------------------
  452. recv 516 bytes from udp/[192.168.1.161]:5060 at 13:04:39.662695:
  453.    ------------------------------------------------------------------------
  454.    SIP/2.0 180 Ringing
  455.    Via: SIP/2.0/UDP 192.168.1.8;rport;branch=z9hG4bKQZtX9pSBBtXFg
  456.    From: "Extension 1010" <sip:1010@192.168.1.8>;tag=059m98KrvSpUS
  457.    To: <sip:1001@192.168.1.161:5060;transport=udp;user=phone>;tag=b873f3c66ff1edc6
  458.    Call-ID: 6ded1894-af7c-1235-51a3-080027de30fb
  459.    CSeq: 106838675 INVITE
  460.    User-Agent: Grandstream GXV3000 1.2.3.7
  461.    Contact: <sip:1001@192.168.1.161:5060;transport=udp;user=phone>
  462.    Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK,MESSAGE
  463.    Content-Length: 0
  464.  
  465.    ------------------------------------------------------------------------
  466. 2017-05-09 13:04:39.656885 [DEBUG] sofia.c:7048 Channel sofia/internal/1001@192.168.1.161:5060 entering state [proceeding][180]
  467. 2017-05-09 13:04:39.656885 [NOTICE] sofia.c:7156 Ring-Ready sofia/internal/1001@192.168.1.161:5060!
  468. 2017-05-09 13:04:39.656885 [DEBUG] switch_channel.c:3345 (sofia/internal/1001@192.168.1.161:5060) Callstate Change DOWN -> RINGING
  469. 2017-05-09 13:04:39.676766 [INFO] switch_ivr_originate.c:1215 Sending early media
  470. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  471. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  472. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  473. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4491 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  474. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  475. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  476. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  477. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  478. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  479. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4491 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  480. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G723:4:8000:20:6300:1]/[opus:116:48000:20:0:1]
  481. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G723:4:8000:20:6300:1]/[G722:9:8000:20:64000:1]
  482. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G723:4:8000:20:6300:1]/[PCMU:0:8000:20:64000:1]
  483. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G723:4:8000:20:6300:1]/[PCMA:8:8000:20:64000:1]
  484. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
  485. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
  486. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  487. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  488. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [GSM:3:8000:20:13200:1]/[opus:116:48000:20:0:1]
  489. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G722:9:8000:20:64000:1]
  490. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
  491. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
  492. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G726-32:2:8000:20:0:1]/[opus:116:48000:20:0:1]
  493. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G726-32:2:8000:20:0:1]/[G722:9:8000:20:64000:1]
  494. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G726-32:2:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  495. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G726-32:2:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  496. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:3056 Set Codec sofia/internal/1010@192.168.1.8 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  497. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_codec.c:111 sofia/internal/1010@192.168.1.8 Original read codec set to PCMU:0
  498. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4725 No 2833 in SDP. Liberal DTMF mode adding 101 as telephone-event.
  499. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4754 sofia/internal/1010@192.168.1.8 Set 2833 dtmf send payload to 101 recv payload to 101
  500. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H264:99]/[VP8:99]
  501. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H264:99]/[H264:99]
  502. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4969 Video Codec Compare [H264:99] +++ is saved as a match
  503. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H264:99]/[H263:34]
  504. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263:34]/[VP8:99]
  505. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263:34]/[H264:99]
  506. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263:34]/[H263:34]
  507. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4969 Video Codec Compare [H263:34] +++ is saved as a match
  508. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[VP8:99]
  509. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H264:99]
  510. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H263:34]
  511. 2017-05-09 13:04:39.676766 [NOTICE] avcodec.c:1011 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
  512. 2017-05-09 13:04:39.676766 [NOTICE] avcodec.c:1011 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
  513. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:2866 Set VIDEO Codec sofia/internal/1010@192.168.1.8 H264/90000 0 ms
  514. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:6865 AUDIO RTP [sofia/internal/1010@192.168.1.8] 192.168.1.8 port 23390 -> 192.168.1.213 port 5004 codec: 0 ms: 20
  515. 2017-05-09 13:04:39.676766 [DEBUG] switch_rtp.c:4096 Starting timer [soft] 160 bytes per 20ms
  516. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:7166 sofia/internal/1010@192.168.1.8 Set 2833 dtmf send payload to 101
  517. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:7173 sofia/internal/1010@192.168.1.8 Set 2833 dtmf receive payload to 101
  518. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:7196 sofia/internal/1010@192.168.1.8 Set rtp dtmf delay to 40
  519. 2017-05-09 13:04:39.676766 [DEBUG] switch_rtp.c:4107 Starting video timer.
  520. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:7385 VIDEO RTP [sofia/internal/1010@192.168.1.8] 192.168.1.8:30462->192.168.1.213:5006 codec: 99 ms: 0 [SUCCESS]
  521. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:5990 sofia/internal/1010@192.168.1.8 Starting Video thread
  522. 2017-05-09 13:04:39.676766 [DEBUG] switch_core_media.c:5856 sofia/internal/1010@192.168.1.8 Video thread started. Echo is off
  523. 2017-05-09 13:04:39.687150 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1010@192.168.1.8!
  524. 2017-05-09 13:04:39.687150 [DEBUG] switch_channel.c:3473 (sofia/internal/1010@192.168.1.8) Callstate Change RINGING -> EARLY
  525. 2017-05-09 13:04:39.687150 [DEBUG] switch_core_media.c:6848 Audio params are unchanged for sofia/internal/1010@192.168.1.8.
  526. 2017-05-09 13:04:39.687150 [DEBUG] switch_core_media.c:7243 Video params are unchanged for sofia/internal/1010@192.168.1.8.
  527. 2017-05-09 13:04:39.687150 [DEBUG] mod_sofia.c:2363 Ring SDP:
  528. v=0
  529. o=FreeSWITCH 1494326089 1494326090 IN IP4 192.168.1.8
  530. s=FreeSWITCH
  531. c=IN IP4 192.168.1.8
  532. t=0 0
  533. m=audio 23390 RTP/AVP 0 101
  534. a=rtpmap:0 PCMU/8000
  535. a=rtpmap:101 telephone-event/8000
  536. a=fmtp:101 0-16
  537. a=ptime:20
  538. a=sendrecv
  539. m=video 30462 RTP/AVP 99
  540. b=AS:1024
  541. a=rtpmap:99 H264/90000
  542. a=fmtp:99 profile-level-id=428014; packetization-mode=0; sprop-parameter-sets=Z0KADJWgUH5A,aM4Ecs==
  543.  
  544. send 1292 bytes to udp/[192.168.1.213]:5060 at 13:04:39.689766:
  545.    ------------------------------------------------------------------------
  546.    SIP/2.0 183 Session Progress
  547.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bK1b138f55697708d3
  548.    From: <sip:1010@192.168.1.8;user=phone>;tag=7d630af1cba71ad7
  549.    To: <sip:1001@192.168.1.8;user=phone>;tag=Zvgv7D3mZg08D
  550.    Call-ID: f2a3928138c1ad37e315f04189f38bc0@192.168.1.213
  551.    CSeq: 25361 INVITE
  552.    Contact: <sip:1001@192.168.1.8:5060;transport=udp>
  553.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  554.    Accept: application/sdp
  555.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  556.    Supported: timer, path, replaces
  557.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  558.    Content-Type: application/sdp
  559.    Content-Disposition: session
  560.    Content-Length: 380
  561.    Remote-Party-ID: "1001" <sip:1001@192.168.1.8>;party=calling;privacy=off;screen=no
  562.  
  563.    v=0
  564.    o=FreeSWITCH 1494326089 1494326090 IN IP4 192.168.1.8
  565.    s=FreeSWITCH
  566.    c=IN IP4 192.168.1.8
  567.    t=0 0
  568.    m=audio 23390 RTP/AVP 0 101
  569.    a=rtpmap:0 PCMU/8000
  570.    a=rtpmap:101 telephone-event/8000
  571.    a=fmtp:101 0-16
  572.    a=ptime:20
  573.    m=video 30462 RTP/AVP 99
  574.    b=AS:1024
  575.    a=rtpmap:99 H264/90000
  576.    a=fmtp:99 profile-level-id=428014; packetization-mode=0; sprop-parameter-sets=Z0KADJWgUH5A,aM4Ecs==
  577.    ------------------------------------------------------------------------
  578. 2017-05-09 13:04:39.687150 [DEBUG] sofia.c:7048 Channel sofia/internal/1010@192.168.1.8 entering state [early][183]
  579. 2017-05-09 13:04:39.687150 [DEBUG] switch_ivr_originate.c:1273 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  580. 2017-05-09 13:04:39.687150 [DEBUG] switch_core_codec.c:223 sofia/internal/1010@192.168.1.8 Push codec L16:100
  581. 2017-05-09 13:04:39.687150 [DEBUG] switch_ivr_originate.c:1342 Play Ringback Tone [%(2000,4000,440,480)]
  582. 2017-05-09 13:04:39.706763 [INFO] avcodec.c:1069 initializing encoder 352x288
  583. 2017-05-09 13:04:39.706763 [DEBUG] avcodec.c:831 NVENC HW CODEC NOT PRESENT
  584. 2017-05-09 13:04:39.736799 [DEBUG] switch_rtp.c:7229 Correct audio ip/port confirmed.
  585. 2017-05-09 13:04:40.307425 [DEBUG] switch_rtp.c:7229 Correct video ip/port confirmed.
  586. recv 856 bytes from udp/[192.168.1.161]:5060 at 13:04:41.568117:
  587.    ------------------------------------------------------------------------
  588.    SIP/2.0 200 OK
  589.    Via: SIP/2.0/UDP 192.168.1.8;rport;branch=z9hG4bKQZtX9pSBBtXFg
  590.    From: "Extension 1010" <sip:1010@192.168.1.8>;tag=059m98KrvSpUS
  591.    To: <sip:1001@192.168.1.161:5060;transport=udp;user=phone>;tag=b873f3c66ff1edc6
  592.    Call-ID: 6ded1894-af7c-1235-51a3-080027de30fb
  593.    CSeq: 106838675 INVITE
  594.    User-Agent: Grandstream GXV3000 1.2.3.7
  595.    Contact: <sip:1001@192.168.1.161:5060;transport=udp;user=phone>
  596.    Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK,MESSAGE
  597.    Content-Type: application/sdp
  598.    Supported: replaces, timer, 100rel, path
  599.    Content-Length: 270
  600.  
  601.    v=0
  602.    o=1001 8000 8000 IN IP4 192.168.1.161
  603.    s=SIP Call
  604.    c=IN IP4 192.168.1.161
  605.    t=0 0
  606.    m=audio 5004 RTP/AVP 0
  607.    a=sendrecv
  608.    a=rtpmap:0 PCMU/8000
  609.    a=ptime:20
  610.    m=video 5006 RTP/AVP 103
  611.    a=sendrecv
  612.    a=rtpmap:103 H263-1998/90000
  613.    a=fmtp:103 CIF=2 MaxBR=1280
  614.    a=framerate:15
  615.    ------------------------------------------------------------------------
  616. 2017-05-09 13:04:41.567035 [DEBUG] sofia.c:7048 Channel sofia/internal/1001@192.168.1.161:5060 entering state [completing][200]
  617. 2017-05-09 13:04:41.567035 [DEBUG] sofia.c:7058 Remote SDP:
  618. v=0
  619. o=1001 8000 8000 IN IP4 192.168.1.161
  620. s=SIP Call
  621. c=IN IP4 192.168.1.161
  622. t=0 0
  623. m=audio 5004 RTP/AVP 0
  624. a=rtpmap:0 PCMU/8000
  625. a=ptime:20
  626. m=video 5006 RTP/AVP 103
  627. a=rtpmap:103 H263-1998/90000
  628. a=fmtp:103 CIF=2 MaxBR=1280
  629. a=framerate:15
  630.  
  631. send 426 bytes to udp/[192.168.1.161]:5060 at 13:04:41.569842:
  632.    ------------------------------------------------------------------------
  633.    ACK sip:1001@192.168.1.161:5060;transport=udp;user=phone SIP/2.0
  634.    Via: SIP/2.0/UDP 192.168.1.8;rport;branch=z9hG4bKr8KpBjaF82K2B
  635.    Max-Forwards: 70
  636.    From: "Extension 1010" <sip:1010@192.168.1.8>;tag=059m98KrvSpUS
  637.    To: <sip:1001@192.168.1.161:5060;transport=udp;user=phone>;tag=b873f3c66ff1edc6
  638.    Call-ID: 6ded1894-af7c-1235-51a3-080027de30fb
  639.    CSeq: 106838675 ACK
  640.    Contact: <sip:mod_sofia@192.168.1.8:5060>
  641.    Content-Length: 0
  642.  
  643.    ------------------------------------------------------------------------
  644. 2017-05-09 13:04:41.567035 [DEBUG] sofia.c:7048 Channel sofia/internal/1001@192.168.1.161:5060 entering state [ready][200]
  645. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  646. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4491 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  647. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  648. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  649. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  650. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:3056 Set Codec sofia/internal/1001@192.168.1.161:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  651. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_codec.c:111 sofia/internal/1001@192.168.1.161:5060 Original read codec set to PCMU:0
  652. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4725 No 2833 in SDP. Liberal DTMF mode adding 101 as telephone-event.
  653. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4754 sofia/internal/1001@192.168.1.161:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  654. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H264:99]
  655. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H263:34]
  656. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[VP8:99]
  657. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H264:99]
  658. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H263:34]
  659. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4980 No matches with FTMP, fallback to ignoring FMTP
  660. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H264:99]
  661. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H263:34]
  662. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[VP8:99]
  663. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H264:99]
  664. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H263:34]
  665. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4988 No matches with inherit_codec, fallback to ignoring PT
  666. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H264:99]
  667. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H263:34]
  668. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[VP8:99]
  669. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H264:99]
  670. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:4937 Video Codec Compare [H263-1998:103]/[H263:34]
  671. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:6865 AUDIO RTP [sofia/internal/1001@192.168.1.161:5060] 192.168.1.8 port 30494 -> 192.168.1.161 port 5004 codec: 0 ms: 20
  672. 2017-05-09 13:04:41.567035 [DEBUG] switch_rtp.c:4096 Starting timer [soft] 160 bytes per 20ms
  673. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:7166 sofia/internal/1001@192.168.1.161:5060 Set 2833 dtmf send payload to 101
  674. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:7173 sofia/internal/1001@192.168.1.161:5060 Set 2833 dtmf receive payload to 101
  675. 2017-05-09 13:04:41.567035 [DEBUG] switch_core_media.c:7196 sofia/internal/1001@192.168.1.161:5060 Set rtp dtmf delay to 40
  676. 2017-05-09 13:04:41.567035 [NOTICE] sofia.c:8182 Channel [sofia/internal/1001@192.168.1.161:5060] has been answered
  677. 2017-05-09 13:04:41.567035 [DEBUG] switch_channel.c:3772 (sofia/internal/1001@192.168.1.161:5060) Callstate Change RINGING -> ACTIVE
  678. 2017-05-09 13:04:41.576985 [DEBUG] switch_core_codec.c:248 sofia/internal/1010@192.168.1.8 Restore previous codec PCMU:0.
  679. 2017-05-09 13:04:41.576985 [DEBUG] switch_core_media.c:6848 Audio params are unchanged for sofia/internal/1010@192.168.1.8.
  680. 2017-05-09 13:04:41.576985 [DEBUG] switch_core_media.c:7243 Video params are unchanged for sofia/internal/1010@192.168.1.8.
  681. 2017-05-09 13:04:41.576985 [DEBUG] mod_sofia.c:850 Local SDP sofia/internal/1010@192.168.1.8:
  682. v=0
  683. o=FreeSWITCH 1494326089 1494326091 IN IP4 192.168.1.8
  684. s=FreeSWITCH
  685. c=IN IP4 192.168.1.8
  686. t=0 0
  687. m=audio 23390 RTP/AVP 0 101
  688. a=rtpmap:0 PCMU/8000
  689. a=rtpmap:101 telephone-event/8000
  690. a=fmtp:101 0-16
  691. a=ptime:20
  692. a=sendrecv
  693. m=video 30462 RTP/AVP 99
  694. b=AS:1024
  695. a=rtpmap:99 H264/90000
  696. a=fmtp:99 profile-level-id=428014; packetization-mode=0; sprop-parameter-sets=Z0KADJWgUH5A,aM4Ecs==
  697.  
  698. send 1262 bytes to udp/[192.168.1.213]:5060 at 13:04:41.585560:
  699.    ------------------------------------------------------------------------
  700.    SIP/2.0 200 OK
  701.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bK1b138f55697708d3
  702.    From: <sip:1010@192.168.1.8;user=phone>;tag=7d630af1cba71ad7
  703.    To: <sip:1001@192.168.1.8;user=phone>;tag=Zvgv7D3mZg08D
  704.    Call-ID: f2a3928138c1ad37e315f04189f38bc0@192.168.1.213
  705.    CSeq: 25361 INVITE
  706.    Contact: <sip:1001@192.168.1.8:5060;transport=udp>
  707.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  708.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  709.    Supported: timer, path, replaces
  710.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  711.    Content-Type: application/sdp
  712.    Content-Disposition: session
  713.    Content-Length: 380
  714.    Remote-Party-ID: "Outbound Call" <sip:1001@192.168.1.8>;party=calling;privacy=off;screen=no
  715.  
  716.    v=0
  717.    o=FreeSWITCH 1494326089 1494326090 IN IP4 192.168.1.8
  718.    s=FreeSWITCH
  719.    c=IN IP4 192.168.1.8
  720.    t=0 0
  721.    m=audio 23390 RTP/AVP 0 101
  722.    a=rtpmap:0 PCMU/8000
  723.    a=rtpmap:101 telephone-event/8000
  724.    a=fmtp:101 0-16
  725.    a=ptime:20
  726.    m=video 30462 RTP/AVP 99
  727.    b=AS:1024
  728.    a=rtpmap:99 H264/90000
  729.    a=fmtp:99 profile-level-id=428014; packetization-mode=0; sprop-parameter-sets=Z0KADJWgUH5A,aM4Ecs==
  730.    ------------------------------------------------------------------------
  731. 2017-05-09 13:04:41.576985 [DEBUG] sofia.c:7048 Channel sofia/internal/1010@192.168.1.8 entering state [completed][200]
  732. 2017-05-09 13:04:41.576985 [NOTICE] switch_ivr_originate.c:3632 Channel [sofia/internal/1010@192.168.1.8] has been answered
  733. 2017-05-09 13:04:41.586966 [DEBUG] switch_channel.c:3772 (sofia/internal/1010@192.168.1.8) Callstate Change EARLY -> ACTIVE
  734. 2017-05-09 13:04:41.586966 [DEBUG] switch_ivr_originate.c:3690 Originate Resulted in Success: [sofia/internal/1001@192.168.1.161:5060]
  735. 2017-05-09 13:04:41.586966 [DEBUG] switch_ivr_originate.c:3690 Originate Resulted in Success: [sofia/internal/1001@192.168.1.161:5060]
  736. 2017-05-09 13:04:41.586966 [DEBUG] switch_ivr_bridge.c:1601 (sofia/internal/1001@192.168.1.161:5060) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  737. 2017-05-09 13:04:41.586966 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1001@192.168.1.161:5060) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 120)
  738. 2017-05-09 13:04:41.586966 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/1001@192.168.1.161:5060) State EXCHANGE_MEDIA
  739. 2017-05-09 13:04:41.586966 [DEBUG] mod_sofia.c:631 SOFIA EXCHANGE_MEDIA
  740. recv 807 bytes from udp/[192.168.1.213]:5060 at 13:04:41.590932:
  741.    ------------------------------------------------------------------------
  742.    ACK sip:1001@192.168.1.8:5060;transport=udp SIP/2.0
  743.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bKdf7185154f76f127
  744.    From: <sip:1010@192.168.1.8;user=phone>;tag=7d630af1cba71ad7
  745.    To: <sip:1001@192.168.1.8;user=phone>;tag=Zvgv7D3mZg08D
  746.    Contact: <sip:1010@192.168.1.213:5060;transport=udp;user=phone>
  747.    Proxy-Authorization: Digest username="1010", realm="192.168.1.8", algorithm=MD5, uri="sip:1001@192.168.1.8;user=phone", qop=auth, nc=00000001, cnonce="2fd39a1149414526", nonce="54de1791-49ce-48ec-8578-4a0c28cfddf5", response="40a4b0f5a444192dd10241f39b8d9aa4"
  748.    Call-ID: f2a3928138c1ad37e315f04189f38bc0@192.168.1.213
  749.    CSeq: 25361 ACK
  750.    User-Agent: Grandstream GXV3000 1.2.3.7
  751.    Max-Forwards: 70
  752.    Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK,MESSAGE
  753.    Content-Length: 0
  754.  
  755.    ------------------------------------------------------------------------
  756. 2017-05-09 13:04:41.586966 [DEBUG] sofia.c:7048 Channel sofia/internal/1010@192.168.1.8 entering state [ready][200]
  757. 2017-05-09 13:04:41.606993 [DEBUG] switch_rtp.c:7229 Correct video ip/port confirmed.
  758. 2017-05-09 13:04:41.626825 [DEBUG] switch_rtp.c:7229 Correct audio ip/port confirmed.
  759. 2017-05-09 13:04:41.636753 [DEBUG] switch_rtp.c:7229 Correct audio ip/port confirmed.
  760. recv 768 bytes from udp/[192.168.1.47]:62774 at 13:05:20.808994:
  761.    ------------------------------------------------------------------------
  762.    REGISTER sip:192.168.1.8:5060;transport=UDP SIP/2.0
  763.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---0177a60461c5f906;rport
  764.    Max-Forwards: 70
  765.    Contact: <sip:1008@192.168.1.47:62774;rinstance=b1d6eaceac4be127;transport=UDP>
  766.    To: <sip:1008@192.168.1.8:5060;transport=UDP>
  767.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=2e64c554
  768.    Call-ID: km4whV_3_IxyU9l-XOkCTg..
  769.    CSeq: 1180 REGISTER
  770.    Expires: 60
  771.    User-Agent: Zoiper rv2.8.30
  772.    Authorization: Digest username="1008",realm="192.168.1.8",nonce="6ff4b4d4-ff90-4dbb-a393-d0af7b862b71",uri="sip:192.168.1.8:5060;transport=UDP",response="1babb164efa7eedc3c974f7fa5970628",cnonce="e9863d47b3eff4100ad3f2ff9baa7155",nc=00000471,qop=auth,algorithm=MD5
  773.    Allow-Events: presence, kpml, talk
  774.    Content-Length: 0
  775.  
  776.    ------------------------------------------------------------------------
  777. send 643 bytes to udp/[192.168.1.47]:62774 at 13:05:20.811220:
  778.    ------------------------------------------------------------------------
  779.    SIP/2.0 200 OK
  780.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---0177a60461c5f906;rport=62774
  781.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=2e64c554
  782.    To: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=1e3DB44US2ceN
  783.    Call-ID: km4whV_3_IxyU9l-XOkCTg..
  784.    CSeq: 1180 REGISTER
  785.    Contact: <sip:1008@192.168.1.47:62774;rinstance=b1d6eaceac4be127;transport=UDP>;expires=60
  786.    Date: Tue, 09 May 2017 17:05:20 GMT
  787.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  788.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  789.    Supported: timer, path, replaces
  790.    Content-Length: 0
  791.  
  792.    ------------------------------------------------------------------------
  793. freeswitch@freeswitch> sofia global siptrace off
  794. +OK Global siptrace off
  795.  

Reply to "Untitled"