From Joshua Young, 7 Years ago, written in Plain Text.
- go back
Embed
Viewing differences between and sip debug output test
  1. freeswitch@freeswitch>
  2. recv 499 bytes from udp/[192.168.1.47]:62774 at 18:14:19.221546:
  3.    ------------------------------------------------------------------------
  4.    REGISTER sip:192.168.1.8:5060;transport=UDP SIP/2.0
  5.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---7cec3d0ecd5233d3;rport
  6.    Max-Forwards: 70
  7.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>
  8.    To: <sip:1008@192.168.1.8:5060;transport=UDP>
  9.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  10.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  11.    CSeq: 1 REGISTER
  12.    Expires: 60
  13.    User-Agent: Zoiper rv2.8.30
  14.    Allow-Events: presence, kpml, talk
  15.    Content-Length: 0
  16.  
  17.    ------------------------------------------------------------------------
  18. send 640 bytes to udp/[192.168.1.47]:62774 at 18:14:19.222700:
  19.    ------------------------------------------------------------------------
  20.    SIP/2.0 401 Unauthorized
  21.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---7cec3d0ecd5233d3;rport=62774
  22.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  23.    To: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=eXQS2e1UBmB1K
  24.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  25.    CSeq: 1 REGISTER
  26.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  27.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  28.    Supported: timer, path, replaces
  29.    WWW-Authenticate: Digest realm="192.168.1.8", nonce="fcb0f64a-833c-4244-ac93-44e02e26b3c5", algorithm=MD5, qop="auth"
  30.    Content-Length: 0
  31.  
  32.    ------------------------------------------------------------------------
  33. recv 765 bytes from udp/[192.168.1.47]:62774 at 18:14:19.231796:
  34.    ------------------------------------------------------------------------
  35.    REGISTER sip:192.168.1.8:5060;transport=UDP SIP/2.0
  36.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---37f3ddbac49db5e0;rport
  37.    Max-Forwards: 70
  38.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>
  39.    To: <sip:1008@192.168.1.8:5060;transport=UDP>
  40.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  41.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  42.    CSeq: 2 REGISTER
  43.    Expires: 60
  44.    User-Agent: Zoiper rv2.8.30
  45.    Authorization: Digest username="1008",realm="192.168.1.8",nonce="fcb0f64a-833c-4244-ac93-44e02e26b3c5",uri="sip:192.168.1.8:5060;transport=UDP",response="e760c96c474515b3b3c4e1a11501f64b",cnonce="779a9682f96e9762f4fdedcb7214f711",nc=00000001,qop=auth,algorithm=MD5
  46.    Allow-Events: presence, kpml, talk
  47.    Content-Length: 0
  48.  
  49.    ------------------------------------------------------------------------
  50. send 640 bytes to udp/[192.168.1.47]:62774 at 18:14:19.235400:
  51.    ------------------------------------------------------------------------
  52.    SIP/2.0 200 OK
  53.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---37f3ddbac49db5e0;rport=62774
  54.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  55.    To: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=F6gj49HZ8v1KF
  56.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  57.    CSeq: 2 REGISTER
  58.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>;expires=60
  59.    Date: Mon, 08 May 2017 22:14:19 GMT
  60.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  61.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  62.    Supported: timer, path, replaces
  63.    Content-Length: 0
  64.  
  65.    ------------------------------------------------------------------------
  66. send 939 bytes to udp/[192.168.1.47]:62774 at 18:14:19.244273:
  67.    ------------------------------------------------------------------------
  68.    NOTIFY sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP SIP/2.0
  69.    Via: SIP/2.0/UDP 192.168.1.8;rport;branch=z9hG4bKB1Nrm1mvpvc7K
  70.    Max-Forwards: 70
  71.    From: <sip:1008@192.168.1.8>;tag=gFaB642255Q6a
  72.    To: <sip:1008@192.168.1.8>
  73.    Call-ID: 85cf3295-aede-1235-77b2-080027de30fb
  74.    CSeq: 106804765 NOTIFY
  75.    Contact: <sip:mod_sofia@192.168.1.8:5060>
  76.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  77.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  78.    Supported: timer, path, replaces
  79.    Event: message-summary
  80.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  81.    Subscription-State: terminated;reason=noresource
  82.    Content-Type: application/simple-message-summary
  83.    Content-Length: 63
  84.  
  85.    Messages-Waiting: no
  86.    Message-Account: sip:1008@192.168.1.8
  87.  
  88.    ------------------------------------------------------------------------
  89. recv 330 bytes from udp/[192.168.1.47]:62774 at 18:14:19.288170:
  90.    ------------------------------------------------------------------------
  91.    SIP/2.0 200 OK
  92.    Via: SIP/2.0/UDP 192.168.1.8;rport=5060;branch=z9hG4bKB1Nrm1mvpvc7K
  93.    Contact: <sip:192.168.1.47:62774>
  94.    To: <sip:1008@192.168.1.8>;tag=15adf853
  95.    From: <sip:1008@192.168.1.8>;tag=gFaB642255Q6a
  96.    Call-ID: 85cf3295-aede-1235-77b2-080027de30fb
  97.    CSeq: 106804765 NOTIFY
  98.    User-Agent: Zoiper rv2.8.30
  99.    Content-Length: 0
  100.  
  101.    ------------------------------------------------------------------------
  102. recv 1174 bytes from udp/[192.168.1.213]:5060 at 18:14:21.838347:
  103.    ------------------------------------------------------------------------
  104.    INVITE sip:123456@192.168.1.8;user=phone SIP/2.0
  105.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bKfcb46426bb65f977
  106.    From: <sip:1010@192.168.1.8;user=phone>;tag=4df555e3df14ba56
  107.    To: <sip:123456@192.168.1.8;user=phone>
  108.    Contact: <sip:1010@192.168.1.213:5060;transport=udp;user=phone>
  109.    Supported: replaces, timer, path
  110.    Call-ID: 9bf708c585e7d5e0ed74d3562bf702c1@192.168.1.213
  111.    CSeq: 21643 INVITE
  112.    User-Agent: Grandstream GXV3000 1.2.3.7
  113.    Max-Forwards: 70
  114.    Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK,MESSAGE
  115.    Content-Type: application/sdp
  116.    Content-Length: 577
  117.  
  118.    v=0
  119.    o=1010 8000 8000 IN IP4 192.168.1.213
  120.    s=SIP Call
  121.    c=IN IP4 192.168.1.213
  122.    t=0 0
  123.    m=audio 5004 RTP/AVP 0 8 4 18 3 2
  124.    a=sendrecv
  125.    a=rtpmap:0 PCMU/8000
  126.    a=rtpmap:8 PCMA/8000
  127.    a=rtpmap:4 G723/8000
  128.    a=rtpmap:18 G729/8000
  129.    a=rtpmap:3 GSM/8000
  130.    a=rtpmap:2 G726-32/8000
  131.    a=ptime:20
  132.    m=video 5006 RTP/AVP 99 34 103
  133.    a=sendrecv
  134.    a=rtpmap:99 H264/90000
  135.    a=fmtp:99 profile-level-id=428014; packetization-mode=0; sprop-parameter-sets=Z0KADJWgUH5A,aM4Eco==
  136.    a=rtpmap:34 H263/90000
  137.    a=fmtp:34 CIF=2 MaxBR=1280
  138.    a=rtpmap:103 H263-1998/90000
  139.    a=fmtp:103 CIF=2 MaxBR=1280
  140.    a=framerate:15
  141.    ------------------------------------------------------------------------
  142. send 347 bytes to udp/[192.168.1.213]:5060 at 18:14:21.838628:
  143.    ------------------------------------------------------------------------
  144.    SIP/2.0 100 Trying
  145.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bKfcb46426bb65f977
  146.    From: <sip:1010@192.168.1.8;user=phone>;tag=4df555e3df14ba56
  147.    To: <sip:123456@192.168.1.8;user=phone>
  148.    Call-ID: 9bf708c585e7d5e0ed74d3562bf702c1@192.168.1.213
  149.    CSeq: 21643 INVITE
  150.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  151.    Content-Length: 0
  152.  
  153.    ------------------------------------------------------------------------
  154. 2017-05-08 18:14:21.838281 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1010@192.168.1.8 [b12589f9-8f43-43ff-81a4-4ddeb7288326]
  155. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1010@192.168.1.8) Running State Change CS_NEW (Cur 1 Tot 6)
  156. 2017-05-08 18:14:21.838281 [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
  157. 2017-05-08 18:14:21.838281 [DEBUG] sofia.c:9950 IP 192.168.1.213 Approved by acl "domains[]". Access Granted.
  158. 2017-05-08 18:14:21.838281 [DEBUG] sofia.c:7048 Channel sofia/internal/1010@192.168.1.8 entering state [received][100]
  159. 2017-05-08 18:14:21.838281 [DEBUG] sofia.c:7058 Remote SDP:
  160. v=0
  161. o=1010 8000 8000 IN IP4 192.168.1.213
  162. s=SIP Call
  163. c=IN IP4 192.168.1.213
  164. t=0 0
  165. m=audio 5004 RTP/AVP 0 8 4 18 3 2
  166. a=rtpmap:0 PCMU/8000
  167. a=rtpmap:8 PCMA/8000
  168. a=rtpmap:4 G723/8000
  169. a=rtpmap:18 G729/8000
  170. a=rtpmap:3 GSM/8000
  171. a=rtpmap:2 G726-32/8000
  172. a=ptime:20
  173. m=video 5006 RTP/AVP 99 34 103
  174. a=rtpmap:99 H264/90000
  175. a=fmtp:99 profile-level-id=428014; packetization-mode=0; sprop-parameter-sets=Z0KADJWgUH5A,aM4Eco==
  176. a=rtpmap:34 H263/90000
  177. a=fmtp:34 CIF=2 MaxBR=1280
  178. a=rtpmap:103 H263-1998/90000
  179. a=fmtp:103 CIF=2 MaxBR=1280
  180. a=framerate:15
  181.  
  182. 2017-05-08 18:14:21.838281 [DEBUG] sofia.c:7450 (sofia/internal/1010@192.168.1.8) State Change CS_NEW -> CS_INIT
  183. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/1010@192.168.1.8) State NEW
  184. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1010@192.168.1.8) Running State Change CS_INIT (Cur 1 Tot 6)
  185. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1010@192.168.1.8) State INIT
  186. 2017-05-08 18:14:21.838281 [DEBUG] mod_sofia.c:90 sofia/internal/1010@192.168.1.8 SOFIA INIT
  187. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1010@192.168.1.8 Standard INIT
  188. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1010@192.168.1.8) State Change CS_INIT -> CS_ROUTING
  189. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1010@192.168.1.8) State INIT going to sleep
  190. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1010@192.168.1.8) Running State Change CS_ROUTING (Cur 1 Tot 6)
  191. 2017-05-08 18:14:21.838281 [DEBUG] switch_channel.c:2249 (sofia/internal/1010@192.168.1.8) Callstate Change DOWN -> RINGING
  192. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1010@192.168.1.8) State ROUTING
  193. 2017-05-08 18:14:21.838281 [DEBUG] mod_sofia.c:143 sofia/internal/1010@192.168.1.8 SOFIA ROUTING
  194. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:236 sofia/internal/1010@192.168.1.8 Standard ROUTING
  195. 2017-05-08 18:14:21.838281 [INFO] mod_dialplan_xml.c:637 Processing 1010 <1010>->123456 in context public
  196. Dialplan: sofia/internal/1010@192.168.1.8 parsing [public->unloop] continue=false
  197. Dialplan: sofia/internal/1010@192.168.1.8 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  198. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  199. Dialplan: sofia/internal/1010@192.168.1.8 parsing [public->outside_call] continue=true
  200. Dialplan: sofia/internal/1010@192.168.1.8 Absolute Condition [outside_call]
  201. Dialplan: sofia/internal/1010@192.168.1.8 Action set(outside_call=true)
  202. Dialplan: sofia/internal/1010@192.168.1.8 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  203. Dialplan: sofia/internal/1010@192.168.1.8 parsing [public->call_debug] continue=true
  204. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
  205. Dialplan: sofia/internal/1010@192.168.1.8 parsing [public->public_extensions] continue=false
  206. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [public_extensions] destination_number(123456) =~ /^(10[01][0-9])$/ break=on-false
  207. Dialplan: sofia/internal/1010@192.168.1.8 parsing [public->public_did] continue=false
  208. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [public_did] destination_number(123456) =~ /^(5551212)$/ break=on-false
  209. Dialplan: sofia/internal/1010@192.168.1.8 parsing [public->dial-10-digit-numbers] continue=false
  210. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [dial-10-digit-numbers] destination_number(123456) =~ /^(\d{10})$/ break=on-false
  211. Dialplan: sofia/internal/1010@192.168.1.8 parsing [public->Calls from dot 9] continue=false
  212. Dialplan: sofia/internal/1010@192.168.1.8 Regex (FAIL) [Calls from dot 9] destination_number(123456) =~ /^(11\d\d)$/ break=on-false
  213. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/1010@192.168.1.8) State Change CS_ROUTING -> CS_EXECUTE
  214. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1010@192.168.1.8) State ROUTING going to sleep
  215. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1010@192.168.1.8) Running State Change CS_EXECUTE (Cur 1 Tot 6)
  216. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1010@192.168.1.8) State EXECUTE
  217. 2017-05-08 18:14:21.838281 [DEBUG] mod_sofia.c:198 sofia/internal/1010@192.168.1.8 SOFIA EXECUTE
  218. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:328 sofia/internal/1010@192.168.1.8 Standard EXECUTE
  219. EXECUTE sofia/internal/1010@192.168.1.8 set(outside_call=true)
  220. 2017-05-08 18:14:21.838281 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1010@192.168.1.8 [outside_call]=[true]
  221. EXECUTE sofia/internal/1010@192.168.1.8 export(RFC2822_DATE=Mon, 08 May 2017 18:14:21 -0400)
  222. 2017-05-08 18:14:21.838281 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Mon, 08 May 2017 18:14:21 -0400]
  223. 2017-05-08 18:14:21.838281 [NOTICE] switch_core_state_machine.c:385 sofia/internal/1010@192.168.1.8 has executed the last dialplan instruction, hanging up.
  224. 2017-05-08 18:14:21.838281 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/internal/1010@192.168.1.8 [CS_EXECUTE] [NORMAL_CLEARING]
  225. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1010@192.168.1.8) State EXECUTE going to sleep
  226. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1010@192.168.1.8) Running State Change CS_HANGUP (Cur 1 Tot 6)
  227. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1010@192.168.1.8) Callstate Change RINGING -> HANGUP
  228. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1010@192.168.1.8) State HANGUP
  229. 2017-05-08 18:14:21.838281 [DEBUG] mod_sofia.c:438 Channel sofia/internal/1010@192.168.1.8 hanging up, cause: NORMAL_CLEARING
  230. 2017-05-08 18:14:21.838281 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 480
  231. send 875 bytes to udp/[192.168.1.213]:5060 at 18:14:21.843043:
  232.    ------------------------------------------------------------------------
  233.    SIP/2.0 480 Temporarily Unavailable
  234.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bKfcb46426bb65f977
  235.    Max-Forwards: 70
  236.    From: <sip:1010@192.168.1.8;user=phone>;tag=4df555e3df14ba56
  237.    To: <sip:123456@192.168.1.8;user=phone>;tag=Hr337ZK62eeSp
  238.    Call-ID: 9bf708c585e7d5e0ed74d3562bf702c1@192.168.1.213
  239.    CSeq: 21643 INVITE
  240.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  241.    Accept: application/sdp
  242.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  243.    Supported: timer, path, replaces
  244.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  245.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  246.    Content-Length: 0
  247.    Remote-Party-ID: "123456" <sip:123456@192.168.1.8>;party=calling;privacy=off;screen=no
  248.  
  249.    ------------------------------------------------------------------------
  250. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1010@192.168.1.8 Standard HANGUP, cause: NORMAL_CLEARING
  251. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1010@192.168.1.8) State HANGUP going to sleep
  252. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1010@192.168.1.8) State Change CS_HANGUP -> CS_REPORTING
  253. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1010@192.168.1.8) Running State Change CS_REPORTING (Cur 1 Tot 6)
  254. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1010@192.168.1.8) State REPORTING
  255. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1010@192.168.1.8 Standard REPORTING, cause: NORMAL_CLEARING
  256. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1010@192.168.1.8) State REPORTING going to sleep
  257. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1010@192.168.1.8) State Change CS_REPORTING -> CS_DESTROY
  258. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_session.c:1664 Session 6 (sofia/internal/1010@192.168.1.8) Locked, Waiting on external entities
  259. 2017-05-08 18:14:21.838281 [NOTICE] switch_core_session.c:1682 Session 6 (sofia/internal/1010@192.168.1.8) Ended
  260. 2017-05-08 18:14:21.838281 [NOTICE] switch_core_session.c:1686 Close Channel sofia/internal/1010@192.168.1.8 [CS_DESTROY]
  261. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1010@192.168.1.8) Running State Change CS_DESTROY (Cur 0 Tot 6)
  262. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1010@192.168.1.8) State DESTROY
  263. 2017-05-08 18:14:21.838281 [DEBUG] mod_sofia.c:343 sofia/internal/1010@192.168.1.8 SOFIA DESTROY
  264. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1010@192.168.1.8 Standard DESTROY
  265. 2017-05-08 18:14:21.838281 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1010@192.168.1.8) State DESTROY going to sleep
  266. recv 542 bytes from udp/[192.168.1.213]:5060 at 18:14:21.846282:
  267.    ------------------------------------------------------------------------
  268.    ACK sip:123456@192.168.1.8;user=phone SIP/2.0
  269.    Via: SIP/2.0/UDP 192.168.1.213:5060;branch=z9hG4bKfcb46426bb65f977
  270.    From: <sip:1010@192.168.1.8;user=phone>;tag=4df555e3df14ba56
  271.    To: <sip:123456@192.168.1.8;user=phone>;tag=Hr337ZK62eeSp
  272.    Contact: <sip:1010@192.168.1.213:5060;transport=udp;user=phone>
  273.    Call-ID: 9bf708c585e7d5e0ed74d3562bf702c1@192.168.1.213
  274.    CSeq: 21643 ACK
  275.    User-Agent: Grandstream GXV3000 1.2.3.7
  276.    Max-Forwards: 70
  277.    Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK,MESSAGE
  278.    Content-Length: 0
  279.  
  280.    ------------------------------------------------------------------------
  281. recv 765 bytes from udp/[192.168.1.47]:62774 at 18:15:13.249294:
  282.    ------------------------------------------------------------------------
  283.    REGISTER sip:192.168.1.8:5060;transport=UDP SIP/2.0
  284.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---34f072649ebfab47;rport
  285.    Max-Forwards: 70
  286.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>
  287.    To: <sip:1008@192.168.1.8:5060;transport=UDP>
  288.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  289.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  290.    CSeq: 3 REGISTER
  291.    Expires: 60
  292.    User-Agent: Zoiper rv2.8.30
  293.    Authorization: Digest username="1008",realm="192.168.1.8",nonce="fcb0f64a-833c-4244-ac93-44e02e26b3c5",uri="sip:192.168.1.8:5060;transport=UDP",response="cf6db6e9dd7911916b532faa3cfd04cb",cnonce="7621435d6481414e8e9045437cce92e5",nc=00000002,qop=auth,algorithm=MD5
  294.    Allow-Events: presence, kpml, talk
  295.    Content-Length: 0
  296.  
  297.    ------------------------------------------------------------------------
  298. send 640 bytes to udp/[192.168.1.47]:62774 at 18:15:13.251014:
  299.    ------------------------------------------------------------------------
  300.    SIP/2.0 200 OK
  301.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---34f072649ebfab47;rport=62774
  302.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  303.    To: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=j1vv9t49ZQ4Bj
  304.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  305.    CSeq: 3 REGISTER
  306.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>;expires=60
  307.    Date: Mon, 08 May 2017 22:15:13 GMT
  308.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  309.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  310.    Supported: timer, path, replaces
  311.    Content-Length: 0
  312.  
  313.    ------------------------------------------------------------------------
  314. recv 765 bytes from udp/[192.168.1.47]:62774 at 18:16:07.269196:
  315.    ------------------------------------------------------------------------
  316.    REGISTER sip:192.168.1.8:5060;transport=UDP SIP/2.0
  317.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---b3b6621cb31f5433;rport
  318.    Max-Forwards: 70
  319.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>
  320.    To: <sip:1008@192.168.1.8:5060;transport=UDP>
  321.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  322.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  323.    CSeq: 4 REGISTER
  324.    Expires: 60
  325.    User-Agent: Zoiper rv2.8.30
  326.    Authorization: Digest username="1008",realm="192.168.1.8",nonce="fcb0f64a-833c-4244-ac93-44e02e26b3c5",uri="sip:192.168.1.8:5060;transport=UDP",response="e4d87b3f721561f007ecdeb369d5a361",cnonce="7190d060429b896fe611ca8158b71f59",nc=00000003,qop=auth,algorithm=MD5
  327.    Allow-Events: presence, kpml, talk
  328.    Content-Length: 0
  329.  
  330.    ------------------------------------------------------------------------
  331. send 640 bytes to udp/[192.168.1.47]:62774 at 18:16:07.271014:
  332.    ------------------------------------------------------------------------
  333.    SIP/2.0 200 OK
  334.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---b3b6621cb31f5433;rport=62774
  335.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  336.    To: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=KapNBpNDX0tyD
  337.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  338.    CSeq: 4 REGISTER
  339.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>;expires=60
  340.    Date: Mon, 08 May 2017 22:16:07 GMT
  341.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  342.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  343.    Supported: timer, path, replaces
  344.    Content-Length: 0
  345.  
  346.    ------------------------------------------------------------------------
  347. recv 765 bytes from udp/[192.168.1.47]:62774 at 18:17:01.284587:
  348.    ------------------------------------------------------------------------
  349.    REGISTER sip:192.168.1.8:5060;transport=UDP SIP/2.0
  350.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---edf1a82590ccfb33;rport
  351.    Max-Forwards: 70
  352.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>
  353.    To: <sip:1008@192.168.1.8:5060;transport=UDP>
  354.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  355.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  356.    CSeq: 5 REGISTER
  357.    Expires: 60
  358.    User-Agent: Zoiper rv2.8.30
  359.    Authorization: Digest username="1008",realm="192.168.1.8",nonce="fcb0f64a-833c-4244-ac93-44e02e26b3c5",uri="sip:192.168.1.8:5060;transport=UDP",response="fa5ad946febbbfca9699659ae0c53ea1",cnonce="2aace6925e04b4baa8143955e66d4359",nc=00000004,qop=auth,algorithm=MD5
  360.    Allow-Events: presence, kpml, talk
  361.    Content-Length: 0
  362.  
  363.    ------------------------------------------------------------------------
  364. send 640 bytes to udp/[192.168.1.47]:62774 at 18:17:01.286371:
  365.    ------------------------------------------------------------------------
  366.    SIP/2.0 200 OK
  367.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---edf1a82590ccfb33;rport=62774
  368.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  369.    To: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=mKFeDH6gt9gHS
  370.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  371.    CSeq: 5 REGISTER
  372.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>;expires=60
  373.    Date: Mon, 08 May 2017 22:17:01 GMT
  374.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  375.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  376.    Supported: timer, path, replaces
  377.    Content-Length: 0
  378.  
  379.    ------------------------------------------------------------------------
  380. recv 765 bytes from udp/[192.168.1.47]:62774 at 18:17:55.311950:
  381.    ------------------------------------------------------------------------
  382.    REGISTER sip:192.168.1.8:5060;transport=UDP SIP/2.0
  383.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---1e80e25bcf7df6e2;rport
  384.    Max-Forwards: 70
  385.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>
  386.    To: <sip:1008@192.168.1.8:5060;transport=UDP>
  387.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  388.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  389.    CSeq: 6 REGISTER
  390.    Expires: 60
  391.    User-Agent: Zoiper rv2.8.30
  392.    Authorization: Digest username="1008",realm="192.168.1.8",nonce="fcb0f64a-833c-4244-ac93-44e02e26b3c5",uri="sip:192.168.1.8:5060;transport=UDP",response="3e41c4b6ec1bcf511b46cf4fa23117fc",cnonce="ac44000526d2305a24f2dd5824692af4",nc=00000005,qop=auth,algorithm=MD5
  393.    Allow-Events: presence, kpml, talk
  394.    Content-Length: 0
  395.  
  396.    ------------------------------------------------------------------------
  397. send 640 bytes to udp/[192.168.1.47]:62774 at 18:17:55.314358:
  398.    ------------------------------------------------------------------------
  399.    SIP/2.0 200 OK
  400.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---1e80e25bcf7df6e2;rport=62774
  401.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  402.    To: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=Nv86ecQmQj73m
  403.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  404.    CSeq: 6 REGISTER
  405.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>;expires=60
  406.    Date: Mon, 08 May 2017 22:17:55 GMT
  407.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  408.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  409.    Supported: timer, path, replaces
  410.    Content-Length: 0
  411.  
  412.    ------------------------------------------------------------------------
  413. recv 765 bytes from udp/[192.168.1.47]:62774 at 18:18:49.332674:
  414.    ------------------------------------------------------------------------
  415.    REGISTER sip:192.168.1.8:5060;transport=UDP SIP/2.0
  416.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---671242f1a842b2a7;rport
  417.    Max-Forwards: 70
  418.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>
  419.    To: <sip:1008@192.168.1.8:5060;transport=UDP>
  420.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  421.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  422.    CSeq: 7 REGISTER
  423.    Expires: 60
  424.    User-Agent: Zoiper rv2.8.30
  425.    Authorization: Digest username="1008",realm="192.168.1.8",nonce="fcb0f64a-833c-4244-ac93-44e02e26b3c5",uri="sip:192.168.1.8:5060;transport=UDP",response="7548905b47988ba52b04e1fa0567f7fd",cnonce="cdecf685ff01ed41410ea5edb88a7bd9",nc=00000006,qop=auth,algorithm=MD5
  426.    Allow-Events: presence, kpml, talk
  427.    Content-Length: 0
  428.  
  429.    ------------------------------------------------------------------------
  430. send 640 bytes to udp/[192.168.1.47]:62774 at 18:18:49.334451:
  431.    ------------------------------------------------------------------------
  432.    SIP/2.0 200 OK
  433.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---671242f1a842b2a7;rport=62774
  434.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  435.    To: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=p51Zg77QmUXpg
  436.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  437.    CSeq: 7 REGISTER
  438.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>;expires=60
  439.    Date: Mon, 08 May 2017 22:18:49 GMT
  440.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  441.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  442.    Supported: timer, path, replaces
  443.    Content-Length: 0
  444.  
  445.    ------------------------------------------------------------------------
  446. recv 765 bytes from udp/[192.168.1.47]:62774 at 18:19:43.352982:
  447.    ------------------------------------------------------------------------
  448.    REGISTER sip:192.168.1.8:5060;transport=UDP SIP/2.0
  449.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---c94cf3c7d5b6a7c1;rport
  450.    Max-Forwards: 70
  451.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>
  452.    To: <sip:1008@192.168.1.8:5060;transport=UDP>
  453.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  454.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  455.    CSeq: 8 REGISTER
  456.    Expires: 60
  457.    User-Agent: Zoiper rv2.8.30
  458.    Authorization: Digest username="1008",realm="192.168.1.8",nonce="fcb0f64a-833c-4244-ac93-44e02e26b3c5",uri="sip:192.168.1.8:5060;transport=UDP",response="e725c9e6cc5054e9acf573f2a499d6d6",cnonce="e4703cf4360dd0a60796417b18b19445",nc=00000007,qop=auth,algorithm=MD5
  459.    Allow-Events: presence, kpml, talk
  460.    Content-Length: 0
  461.  
  462.    ------------------------------------------------------------------------
  463. send 640 bytes to udp/[192.168.1.47]:62774 at 18:19:43.354870:
  464.    ------------------------------------------------------------------------
  465.    SIP/2.0 200 OK
  466.    Via: SIP/2.0/UDP 192.168.1.47:62774;branch=z9hG4bK-524287-1---c94cf3c7d5b6a7c1;rport=62774
  467.    From: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=15c4215a
  468.    To: <sip:1008@192.168.1.8:5060;transport=UDP>;tag=QeUrj2rUH4K9B
  469.    Call-ID: ZjdLSPb86MPCiU4PQSdWkg..
  470.    CSeq: 8 REGISTER
  471.    Contact: <sip:1008@192.168.1.47:62774;rinstance=c02f003471180104;transport=UDP>;expires=60
  472.    Date: Mon, 08 May 2017 22:19:43 GMT
  473.    User-Agent: FreeSWITCH-mod_sofia/1.6.17-34-0fc0946~64bit
  474.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  475.    Supported: timer, path, replaces
  476.    Content-Length: 0
  477.  
  478.    ------------------------------------------------------------------------
  479.