recv 1510 bytes from udp/[207.2.108.90]:5060 at 06:25:16.383935:
------------------------------------------------------------------------
INVITE sip:1003@servpac.com SIP/2.0
Via: SIP/2.0/UDP 207.2.108.90;rport;branch=z9hG4bKN7X31tpyQFgZg
Route: <sip:217.12.247.212>
Max-Forwards: 70
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513894 INVITE
Contact: <sip:mod_sofia@207.2.108.90:5060>
User-Agent: Servpac VOIP v5
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 615
X-FS-Support: update_display,send_info
Remote-Party-ID: <sip:safarov@servpac.com>;party=calling;screen=yes;privacy=off
v=0
o=Servpac 1521675148 1521675149 IN IP4 207.2.108.90
s=Servpac
c=IN IP4 207.2.108.90
t=0 0
m=audio 24768 RTP/AVP 102 9 0 8 104 101
a=rtpmap:102 opus/48000/2
a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:104 telephone-event/48000
a=fmtp:104 0-16
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
m=video 26146 RTP/AVP 103
b=AS:1024
a=rtpmap:103 VP8/90000
a=rtcp-fb:103 ccm fir
a=rtcp-fb:103 ccm tmmbr
a=rtcp-fb:103 nack
a=rtcp-fb:103 nack pli
------------------------------------------------------------------------
send 343 bytes to udp/[207.2.108.90]:5060 at 06:25:16.384197:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 207.2.108.90;rport=5060;branch=z9hG4bKN7X31tpyQFgZg
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513894 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:16.383700 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/safarov@servpac.com [3e19875d-1df1-4633-800b-af6cd40b2ab7]
2018-03-22 06:25:16.383700 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/safarov@servpac.com) Running State Change CS_NEW (Cur 1 Tot 105)
2018-03-22 06:25:16.383700 [DEBUG] sofia.c:9873 sofia/internal/safarov@servpac.com receiving invite from 207.2.108.90:5060 version: 1.6.20+git git b46d864 2018-01-27 11:52:21Z 64bit
2018-03-22 06:25:16.383700 [DEBUG] sofia.c:10044 IP 207.2.108.90 Rejected by acl "domains". Falling back to Digest auth.
2018-03-22 06:25:16.383700 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/safarov@servpac.com) State NEW
send 845 bytes to udp/[207.2.108.90]:5060 at 06:25:16.385758:
------------------------------------------------------------------------
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 207.2.108.90;rport=5060;branch=z9hG4bKN7X31tpyQFgZg
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>;tag=jvy8eQD81ZUtH
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513894 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Proxy-Authenticate: Digest realm="servpac.com", nonce="570edbb0-eeb7-4511-9501-daa59b8b4c1a", algorithm=MD5, qop="auth"
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:16.383700 [DEBUG] sofia.c:2334 detaching session 3e19875d-1df1-4633-800b-af6cd40b2ab7
recv 335 bytes from udp/[207.2.108.90]:5060 at 06:25:16.630911:
------------------------------------------------------------------------
ACK sip:1003@servpac.com SIP/2.0
Via: SIP/2.0/UDP 207.2.108.90;rport;branch=z9hG4bKN7X31tpyQFgZg
Route: <sip:217.12.247.212>
Max-Forwards: 70
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>;tag=jvy8eQD81ZUtH
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513894 ACK
Content-Length: 0
------------------------------------------------------------------------
recv 1769 bytes from udp/[207.2.108.90]:5060 at 06:25:16.637398:
------------------------------------------------------------------------
INVITE sip:1003@servpac.com SIP/2.0
Via: SIP/2.0/UDP 207.2.108.90;rport;branch=z9hG4bKpgQv3N71mr6Hc
Route: <sip:217.12.247.212>
Max-Forwards: 70
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513895 INVITE
Contact: <sip:mod_sofia@207.2.108.90:5060>
User-Agent: Servpac VOIP v5
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Proxy-Authorization: Digest username="safarov", realm="servpac.com", nonce="570edbb0-eeb7-4511-9501-daa59b8b4c1a", cnonce="oO3Noag8Ejax9ABQVqFxWg", algorithm=MD5, uri="sip:1003@servpac.com", response="c6093cc2ecb1d5f85589b6284f66223e", qop=auth, nc=00000001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 615
X-FS-Support: update_display,send_info
Remote-Party-ID: <sip:safarov@servpac.com>;party=calling;screen=yes;privacy=off
v=0
o=Servpac 1521675148 1521675149 IN IP4 207.2.108.90
s=Servpac
c=IN IP4 207.2.108.90
t=0 0
m=audio 24768 RTP/AVP 102 9 0 8 104 101
a=rtpmap:102 opus/48000/2
a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:104 telephone-event/48000
a=fmtp:104 0-16
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
m=video 26146 RTP/AVP 103
b=AS:1024
a=rtpmap:103 VP8/90000
a=rtcp-fb:103 ccm fir
a=rtcp-fb:103 ccm tmmbr
a=rtcp-fb:103 nack
a=rtcp-fb:103 nack pli
------------------------------------------------------------------------
send 343 bytes to udp/[207.2.108.90]:5060 at 06:25:16.637592:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 207.2.108.90;rport=5060;branch=z9hG4bKpgQv3N71mr6Hc
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513895 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:16.633691 [DEBUG] sofia.c:2442 Re-attaching to session 3e19875d-1df1-4633-800b-af6cd40b2ab7
2018-03-22 06:25:16.643696 [DEBUG] sofia.c:9873 sofia/internal/safarov@servpac.com receiving invite from 207.2.108.90:5060 version: 1.6.20+git git b46d864 2018-01-27 11:52:21Z 64bit
2018-03-22 06:25:16.643696 [DEBUG] sofia.c:10044 IP 207.2.108.90 Rejected by acl "domains". Falling back to Digest auth.
2018-03-22 06:25:16.643696 [DEBUG] sofia.c:7084 Channel sofia/internal/safarov@servpac.com entering state [received][100]
2018-03-22 06:25:16.643696 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=Servpac 1521675148 1521675149 IN IP4 207.2.108.90
s=Servpac
c=IN IP4 207.2.108.90
t=0 0
m=audio 24768 RTP/AVP 102 9 0 8 104 101
a=rtpmap:102 opus/48000/2
a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:104 telephone-event/48000
a=fmtp:104 0-16
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
m=video 26146 RTP/AVP 103
b=AS:1024
a=rtpmap:103 VP8/90000
a=rtcp-fb:103 ccm fir
a=rtcp-fb:103 ccm tmmbr
a=rtcp-fb:103 nack
a=rtcp-fb:103 nack pli
2018-03-22 06:25:16.643696 [DEBUG] sofia.c:7486 (sofia/internal/safarov@servpac.com) State Change CS_NEW -> CS_INIT
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/safarov@servpac.com) Running State Change CS_INIT (Cur 1 Tot 105)
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/safarov@servpac.com) State INIT
2018-03-22 06:25:16.643696 [DEBUG] mod_sofia.c:90 sofia/internal/safarov@servpac.com SOFIA INIT
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:40 sofia/internal/safarov@servpac.com Standard INIT
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/safarov@servpac.com) State Change CS_INIT -> CS_ROUTING
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/safarov@servpac.com) State INIT going to sleep
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/safarov@servpac.com) Running State Change CS_ROUTING (Cur 1 Tot 105)
2018-03-22 06:25:16.643696 [DEBUG] switch_channel.c:2249 (sofia/internal/safarov@servpac.com) Callstate Change DOWN -> RINGING
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/safarov@servpac.com) State ROUTING
2018-03-22 06:25:16.643696 [DEBUG] mod_sofia.c:143 sofia/internal/safarov@servpac.com SOFIA ROUTING
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:236 sofia/internal/safarov@servpac.com Standard ROUTING
2018-03-22 06:25:16.643696 [INFO] mod_dialplan_xml.c:637 Processing <safarov>->1003 in context servpac.com
Dialplan: sofia/internal/safarov@servpac.com parsing [servpac.com->dial_via_directory] continue=false
Dialplan: sofia/internal/safarov@servpac.com Regex (PASS) [dial_via_directory] destination_number(1003) =~ /^1\d\d\d$/ break=on-false
Dialplan: sofia/internal/safarov@servpac.com Action export(fax_enable_t38=true)
Dialplan: sofia/internal/safarov@servpac.com Action export(t38_passthru=true)
Dialplan: sofia/internal/safarov@servpac.com Action bridge(user/${user_data(${destination_number}@${sip_to_host} attr id)}@${sip_to_host})
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/safarov@servpac.com) State Change CS_ROUTING -> CS_EXECUTE
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/safarov@servpac.com) State ROUTING going to sleep
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/safarov@servpac.com) Running State Change CS_EXECUTE (Cur 1 Tot 105)
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/safarov@servpac.com) State EXECUTE
2018-03-22 06:25:16.643696 [DEBUG] mod_sofia.c:198 sofia/internal/safarov@servpac.com SOFIA EXECUTE
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:328 sofia/internal/safarov@servpac.com Standard EXECUTE
EXECUTE sofia/internal/safarov@servpac.com export(fax_enable_t38=true)
2018-03-22 06:25:16.643696 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [fax_enable_t38]=[true]
EXECUTE sofia/internal/safarov@servpac.com export(t38_passthru=true)
2018-03-22 06:25:16.643696 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [t38_passthru]=[true]
EXECUTE sofia/internal/safarov@servpac.com bridge(user/efax@servpac.com)
2018-03-22 06:25:16.643696 [DEBUG] switch_channel.c:1250 sofia/internal/safarov@servpac.com EXPORTING[export_vars] [fax_enable_t38]=[true] to event
2018-03-22 06:25:16.643696 [DEBUG] switch_channel.c:1250 sofia/internal/safarov@servpac.com EXPORTING[export_vars] [t38_passthru]=[true] to event
2018-03-22 06:25:16.643696 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
2018-03-22 06:25:16.643696 [DEBUG] switch_channel.c:1250 sofia/internal/safarov@servpac.com EXPORTING[export_vars] [fax_enable_t38]=[true] to event
2018-03-22 06:25:16.643696 [DEBUG] switch_channel.c:1250 sofia/internal/safarov@servpac.com EXPORTING[export_vars] [t38_passthru]=[true] to event
2018-03-22 06:25:16.643696 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
2018-03-22 06:25:16.643696 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
2018-03-22 06:25:16.643696 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1003@207.2.108.149 [a4f23040-af7d-4da5-b09c-ecde78954427]
2018-03-22 06:25:16.643696 [DEBUG] mod_sofia.c:4819 (sofia/internal/1003@207.2.108.149) State Change CS_NEW -> CS_INIT
2018-03-22 06:25:16.643696 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@207.2.108.149) Running State Change CS_INIT (Cur 2 Tot 106)
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1003@207.2.108.149) State INIT
2018-03-22 06:25:16.643696 [DEBUG] mod_sofia.c:90 sofia/internal/1003@207.2.108.149 SOFIA INIT
2018-03-22 06:25:16.643696 [DEBUG] sofia_glue.c:1295 sofia/internal/1003@207.2.108.149 sending invite version: 1.6.20+git git b46d864 2018-01-27 11:52:21Z 64bit
Local SDP:
v=0
o=FreeSWITCH 1521678050 1521678051 IN IP4 217.12.247.212
s=FreeSWITCH
c=IN IP4 217.12.247.212
t=0 0
m=audio 21866 RTP/AVP 102 9 0 8 104 101
a=rtpmap:102 opus/48000/2
a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:104 telephone-event/48000
a=fmtp:104 0-16
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
m=video 31192 RTP/AVP 103
b=AS:1024
a=rtpmap:103 VP8/90000
a=rtcp-fb:103 ccm fir
a=rtcp-fb:103 ccm tmmbr
a=rtcp-fb:103 nack
a=rtcp-fb:103 nack pli
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1003@207.2.108.149 Standard INIT
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1003@207.2.108.149) State Change CS_INIT -> CS_ROUTING
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1003@207.2.108.149) State INIT going to sleep
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@207.2.108.149) Running State Change CS_ROUTING (Cur 2 Tot 106)
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1003@207.2.108.149) State ROUTING
2018-03-22 06:25:16.643696 [DEBUG] mod_sofia.c:143 sofia/internal/1003@207.2.108.149 SOFIA ROUTING
2018-03-22 06:25:16.643696 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/1003@207.2.108.149) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1003@207.2.108.149) State ROUTING going to sleep
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@207.2.108.149) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 106)
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1003@207.2.108.149) State CONSUME_MEDIA
2018-03-22 06:25:16.643696 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1003@207.2.108.149) State CONSUME_MEDIA going to sleep
send 1559 bytes to udp/[207.2.108.149]:5060 at 06:25:16.653833:
------------------------------------------------------------------------
INVITE sip:1003@207.2.108.149 SIP/2.0
Via: SIP/2.0/UDP 217.12.247.212;rport;branch=z9hG4bKr7H8ygZFerv7F
Max-Forwards: 69
From: "" <sip:safarov@servpac.com>;tag=meHtjDFFvH8Zr
To: <sip:1003@207.2.108.149>
Call-ID: a0bdeff6-a83c-1236-dc98-000c296ca80b
CSeq: 120513894 INVITE
Contact: <sip:mod_sofia@217.12.247.212:5060>
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 635
X-FS-Support: update_display,send_info
Remote-Party-ID: <sip:safarov@servpac.com>;party=calling;screen=yes;privacy=off
v=0
o=FreeSWITCH 1521678050 1521678051 IN IP4 217.12.247.212
s=FreeSWITCH
c=IN IP4 217.12.247.212
t=0 0
m=audio 21866 RTP/AVP 102 9 0 8 104 101
a=rtpmap:102 opus/48000/2
a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:104 telephone-event/48000
a=fmtp:104 0-16
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
m=video 31192 RTP/AVP 103
b=AS:1024
a=rtpmap:103 VP8/90000
a=rtcp-fb:103 ccm fir
a=rtcp-fb:103 ccm tmmbr
a=rtcp-fb:103 nack
a=rtcp-fb:103 nack pli
------------------------------------------------------------------------
2018-03-22 06:25:16.653936 [DEBUG] sofia.c:7084 Channel sofia/internal/1003@207.2.108.149 entering state [calling][0]
recv 406 bytes from udp/[207.2.108.149]:5060 at 06:25:16.905428:
------------------------------------------------------------------------
SIP/2.0 180 Ringing
From: ""<sip:safarov@servpac.com>;tag=meHtjDFFvH8Zr
To: <sip:1003@207.2.108.149>;tag=ad080630-0-13c4-55013-31073c-7a6207fe-31073c
Call-ID: a0bdeff6-a83c-1236-dc98-000c296ca80b
CSeq: 120513894 INVITE
Via: SIP/2.0/UDP 217.12.247.212;rport=5060;branch=z9hG4bKr7H8ygZFerv7F
Supported: 100rel
User-Agent: Brktsip/6.7.1B3 (Dialogic)
Contact: <sip:207.2.108.149>
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:16.903823 [DEBUG] sofia.c:7084 Channel sofia/internal/1003@207.2.108.149 entering state [proceeding][180]
2018-03-22 06:25:16.903823 [NOTICE] sofia.c:7192 Ring-Ready sofia/internal/1003@207.2.108.149!
2018-03-22 06:25:16.903823 [DEBUG] switch_channel.c:3346 (sofia/internal/1003@207.2.108.149) Callstate Change DOWN -> RINGING
2018-03-22 06:25:16.903823 [NOTICE] mod_sofia.c:2273 Ring-Ready sofia/internal/safarov@servpac.com!
2018-03-22 06:25:16.903823 [NOTICE] switch_ivr_originate.c:525 Ring Ready sofia/internal/safarov@servpac.com!
send 949 bytes to udp/[207.2.108.90]:5060 at 06:25:16.917568:
------------------------------------------------------------------------
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 207.2.108.90;rport=5060;branch=z9hG4bKpgQv3N71mr6Hc
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513895 INVITE
Contact: <sip:1003@217.12.247.212:5060;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Length: 0
X-FS-Display-Name: 1003
X-FS-Display-Number: sip:1003@servpac.com
X-FS-Support: update_display,send_info
Remote-Party-ID: "1003" <sip:1003@servpac.com>;party=calling;privacy=off;screen=no
------------------------------------------------------------------------
2018-03-22 06:25:16.933693 [DEBUG] sofia.c:7084 Channel sofia/internal/safarov@servpac.com entering state [early][180]
recv 631 bytes from udp/[207.2.108.149]:5060 at 06:25:16.956211:
------------------------------------------------------------------------
SIP/2.0 200 OK
From: ""<sip:safarov@servpac.com>;tag=meHtjDFFvH8Zr
To: <sip:1003@207.2.108.149>;tag=ad080630-0-13c4-55013-31073c-7a6207fe-31073c
Call-ID: a0bdeff6-a83c-1236-dc98-000c296ca80b
CSeq: 120513894 INVITE
Via: SIP/2.0/UDP 217.12.247.212;rport=5060;branch=z9hG4bKr7H8ygZFerv7F
Supported: 100rel
User-Agent: Brktsip/6.7.1B3 (Dialogic)
Contact: <sip:207.2.108.149>
Content-Type: application/sdp
Content-Length: 197
v=0
o=- 2212201939 0748369000 IN IP4 207.2.108.149
s=no_session_name
t=0 0
m=audio 56056 RTP/AVP 0
c=IN IP4 207.2.108.149
a=rtpmap:0 PCMU/8000
m=video 0 RTP/AVP 103
c=IN IP4 207.2.108.149
------------------------------------------------------------------------
2018-03-22 06:25:16.953683 [DEBUG] sofia.c:7084 Channel sofia/internal/1003@207.2.108.149 entering state [completing][200]
2018-03-22 06:25:16.953683 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=- 2212201939 748369000 IN IP4 207.2.108.149
s=no_session_name
t=0 0
m=audio 56056 RTP/AVP 0
c=IN IP4 207.2.108.149
a=rtpmap:0 PCMU/8000
m=video 0 RTP/AVP 103
c=IN IP4 207.2.108.149
send 384 bytes to udp/[207.2.108.149]:5060 at 06:25:16.957556:
------------------------------------------------------------------------
ACK sip:207.2.108.149 SIP/2.0
Via: SIP/2.0/UDP 217.12.247.212;rport;branch=z9hG4bKSgB10BgKB1jtB
Max-Forwards: 70
From: "" <sip:safarov@servpac.com>;tag=meHtjDFFvH8Zr
To: <sip:1003@207.2.108.149>;tag=ad080630-0-13c4-55013-31073c-7a6207fe-31073c
Call-ID: a0bdeff6-a83c-1236-dc98-000c296ca80b
CSeq: 120513894 ACK
Contact: <sip:mod_sofia@217.12.247.212:5060>
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:16.953683 [DEBUG] sofia.c:7084 Channel sofia/internal/1003@207.2.108.149 entering state [ready][200]
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:2]
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/1003@207.2.108.149 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
2018-03-22 06:25:16.953683 [DEBUG] switch_core_codec.c:111 sofia/internal/1003@207.2.108.149 Original read codec set to PCMU:0
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:4738 No 2833 in SDP. Liberal DTMF mode adding 101 as telephone-event.
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:4767 sofia/internal/1003@207.2.108.149 Set 2833 dtmf send payload to 101 recv payload to 101
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/1003@207.2.108.149] 217.12.247.212 port 21866 -> 207.2.108.149 port 56056 codec: 0 ms: 20
2018-03-22 06:25:16.953683 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:7180 sofia/internal/1003@207.2.108.149 Set 2833 dtmf send payload to 101
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:7187 sofia/internal/1003@207.2.108.149 Set 2833 dtmf receive payload to 101
2018-03-22 06:25:16.953683 [DEBUG] switch_core_media.c:7210 sofia/internal/1003@207.2.108.149 Set rtp dtmf delay to 40
2018-03-22 06:25:16.953683 [NOTICE] sofia.c:8218 Channel [sofia/internal/1003@207.2.108.149] has been answered
2018-03-22 06:25:16.953683 [DEBUG] switch_channel.c:3773 (sofia/internal/1003@207.2.108.149) Callstate Change RINGING -> ACTIVE
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:102:48000:20:0:1]/[opus:116:48000:20:0:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:102:48000:20:0:1]/[G722:9:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:102:48000:20:0:1]/[PCMU:0:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:102:48000:20:0:1]/[PCMA:8:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 104@48000
2018-03-22 06:25:16.973832 [DEBUG] mod_opus.c:603 Opus encoder: set bitrate to local settings [72000bps]
2018-03-22 06:25:16.973832 [DEBUG] mod_opus.c:603 Opus encoder: set bitrate to local settings [72000bps]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/safarov@servpac.com opus/48000 20 ms 960 samples 0 bits 1 channels
2018-03-22 06:25:16.973832 [DEBUG] switch_core_codec.c:111 sofia/internal/safarov@servpac.com Original read codec set to opus:116
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 104@48000
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4767 sofia/internal/safarov@servpac.com Set 2833 dtmf send payload to 104 recv payload to 104
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4950 Video Codec Compare [VP8:103]/[VP8:99]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:4982 Video Codec Compare [VP8:103] +++ is saved as a match
2018-03-22 06:25:16.973832 [DEBUG] switch_vpx.c:631 VPX VER:v1.6.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7
2018-03-22 06:25:16.973832 [DEBUG] switch_vpx.c:631 VPX VER:v1.6.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:2871 Set VIDEO Codec sofia/internal/safarov@servpac.com VP8/90000 0 ms
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/safarov@servpac.com] 217.12.247.212 port 16812 -> 207.2.108.90 port 24768 codec: 102 ms: 20
2018-03-22 06:25:16.973832 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 960 bytes per 20ms
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:7180 sofia/internal/safarov@servpac.com Set 2833 dtmf send payload to 104
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:7187 sofia/internal/safarov@servpac.com Set 2833 dtmf receive payload to 104
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:7210 sofia/internal/safarov@servpac.com Set rtp dtmf delay to 40
2018-03-22 06:25:16.973832 [DEBUG] switch_rtp.c:4152 Starting video timer.
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:7399 VIDEO RTP [sofia/internal/safarov@servpac.com] 217.12.247.212:31264->207.2.108.90:26146 codec: 103 ms: 0 [SUCCESS]
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:6003 sofia/internal/safarov@servpac.com Starting Video thread
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:5869 sofia/internal/safarov@servpac.com Video thread started. Echo is off
2018-03-22 06:25:16.973832 [INFO] switch_core_media.c:7479 Activating VIDEO RTCP PORT 26147 interval 1000 mux -1
2018-03-22 06:25:16.973832 [DEBUG] switch_rtp.c:4533 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 26147
2018-03-22 06:25:16.973832 [DEBUG] switch_rtp.c:2567 Setting RTCP remote addr to 207.2.108.90:26147 2
2018-03-22 06:25:16.973832 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/safarov@servpac.com!
2018-03-22 06:25:16.973832 [DEBUG] switch_channel.c:3474 (sofia/internal/safarov@servpac.com) Callstate Change RINGING -> EARLY
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/internal/safarov@servpac.com.
2018-03-22 06:25:16.973832 [DEBUG] switch_core_media.c:7257 Video params are unchanged for sofia/internal/safarov@servpac.com.
2018-03-22 06:25:16.973832 [DEBUG] mod_sofia.c:850 Local SDP sofia/internal/safarov@servpac.com:
v=0
o=FreeSWITCH 1521683104 1521683105 IN IP4 217.12.247.212
s=FreeSWITCH
c=IN IP4 217.12.247.212
t=0 0
m=audio 16812 RTP/AVP 102 104
a=rtpmap:102 opus/48000/2
a=fmtp:102 useinbandfec=1; ptime=20; minptime=10; maxptime=40
a=rtpmap:104 telephone-event/48000
a=fmtp:104 0-16
a=ptime:20
a=sendrecv
m=video 31264 RTP/AVP 103
b=AS:1024
a=rtpmap:103 VP8/90000
a=rtcp:31265 IN IP4 217.12.247.212
a=rtcp-fb:103 ccm fir
a=rtcp-fb:103 ccm tmmbr
a=rtcp-fb:103 nack
a=rtcp-fb:103 nack pli
2018-03-22 06:25:16.973832 [NOTICE] switch_ivr_originate.c:3647 Channel [sofia/internal/safarov@servpac.com] has been answered
2018-03-22 06:25:16.973832 [DEBUG] switch_channel.c:3773 (sofia/internal/safarov@servpac.com) Callstate Change EARLY -> ACTIVE
2018-03-22 06:25:16.973832 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/internal/1003@207.2.108.149]
2018-03-22 06:25:16.973832 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/internal/1003@207.2.108.149]
2018-03-22 06:25:16.973832 [DEBUG] switch_ivr_bridge.c:1614 (sofia/internal/1003@207.2.108.149) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
send 1485 bytes to udp/[207.2.108.90]:5060 at 06:25:16.986886:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 207.2.108.90;rport=5060;branch=z9hG4bKpgQv3N71mr6Hc
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513895 INVITE
Contact: <sip:1003@217.12.247.212:5060;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 485
X-FS-Display-Name: Outbound Call
X-FS-Display-Number: sip:1003@servpac.com
X-FS-Support: update_display,send_info
Remote-Party-ID: "Outbound Call" <sip:1003@servpac.com>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1521683104 1521683105 IN IP4 217.12.247.212
s=FreeSWITCH
c=IN IP4 217.12.247.212
t=0 0
m=audio 16812 RTP/AVP 102 104
a=rtpmap:102 opus/48000/2
a=fmtp:102 useinbandfec=1; ptime=20; minptime=10; maxptime=40
a=rtpmap:104 telephone-event/48000
a=fmtp:104 0-16
a=ptime:20
m=video 31264 RTP/AVP 103
b=AS:1024
a=rtpmap:103 VP8/90000
a=rtcp:31265 IN IP4 217.12.247.212
a=rtcp-fb:103 ccm fir
a=rtcp-fb:103 ccm tmmbr
a=rtcp-fb:103 nack
a=rtcp-fb:103 nack pli
------------------------------------------------------------------------
2018-03-22 06:25:16.986660 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@207.2.108.149) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 106)
2018-03-22 06:25:16.986660 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/1003@207.2.108.149) State EXCHANGE_MEDIA
2018-03-22 06:25:16.986660 [DEBUG] mod_sofia.c:631 SOFIA EXCHANGE_MEDIA
2018-03-22 06:25:16.986660 [DEBUG] sofia.c:7084 Channel sofia/internal/safarov@servpac.com entering state [completed][200]
2018-03-22 06:25:17.013702 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
2018-03-22 06:25:17.013702 [NOTICE] switch_core_io.c:1202 Activating write resampler
2018-03-22 06:25:17.093685 [NOTICE] switch_vpx.c:406 VPX reset encoder picture from 320x240 to 352x288 1024 BW
recv 631 bytes from udp/[207.2.108.90]:5060 at 06:25:17.232896:
------------------------------------------------------------------------
ACK sip:1003@217.12.247.212:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 207.2.108.90;rport;branch=z9hG4bKQSgN5gr5H1v4Q
Max-Forwards: 70
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513895 ACK
Contact: <sip:mod_sofia@207.2.108.90:5060>
Proxy-Authorization: Digest username="safarov", realm="servpac.com", nonce="570edbb0-eeb7-4511-9501-daa59b8b4c1a", cnonce="oO3Noag8Ejax9ABQVqFxWg", algorithm=MD5, uri="sip:1003@servpac.com", response="c6093cc2ecb1d5f85589b6284f66223e", qop=auth, nc=00000001
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:17.233696 [DEBUG] sofia.c:7084 Channel sofia/internal/safarov@servpac.com entering state [ready][200]
send 698 bytes to udp/[207.2.108.90]:5060 at 06:25:17.259893:
------------------------------------------------------------------------
INFO sip:mod_sofia@207.2.108.90:5060 SIP/2.0
Via: SIP/2.0/UDP 217.12.247.212;rport;branch=z9hG4bKtS4S260p898cQ
Max-Forwards: 70
From: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
To: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513894 INFO
Contact: <sip:1003@217.12.247.212:5060;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Content-Type: message/update_display
Content-Length: 0
X-FS-Display-Name: Outbound Call
X-FS-Display-Number: 1003
------------------------------------------------------------------------
2018-03-22 06:25:17.353684 [DEBUG] switch_rtp.c:1887 rtcp_stats_init: video ssrc[4117184854] base_seq[45282]
2018-03-22 06:25:17.475632 [DEBUG] switch_rtp.c:7308 Correct video ip/port confirmed.
recv 451 bytes from udp/[207.2.108.90]:5060 at 06:25:17.514459:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 217.12.247.212;rport=5060;branch=z9hG4bKtS4S260p898cQ
From: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
To: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513894 INFO
User-Agent: Servpac VOIP v5
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:17.573687 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
2018-03-22 06:25:17.573687 [NOTICE] switch_core_io.c:1202 Activating write resampler
recv 1296 bytes from udp/[207.2.108.90]:5060 at 06:25:19.514214:
------------------------------------------------------------------------
INVITE sip:1003@217.12.247.212:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 207.2.108.90;rport;branch=z9hG4bKSB3686SccK99e
Max-Forwards: 70
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513896 INVITE
Contact: <sip:mod_sofia@207.2.108.90:5060>
User-Agent: Servpac VOIP v5
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Proxy-Authorization: Digest username="safarov", realm="servpac.com", nonce="570edbb0-eeb7-4511-9501-daa59b8b4c1a", cnonce="oO3Noag8Ejax9ABQVqFxWg", algorithm=MD5, uri="sip:1003@217.12.247.212:5060;transport=udp", response="d7161ca89deab825343e457099121ec3", qop=auth, nc=00000002
Content-Type: application/sdp
Content-Length: 310
X-FS-Support: update_display,send_info
Remote-Party-ID: <sip:safarov@servpac.com>;party=calling;screen=yes;privacy=off
v=0
o=Servpac 1521675148 1521675150 IN IP4 207.2.108.90
s=Servpac
c=IN IP4 207.2.108.90
t=0 0
m=image 24768 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxFillBitRemoval
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:2000
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
------------------------------------------------------------------------
send 361 bytes to udp/[207.2.108.90]:5060 at 06:25:19.514436:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 207.2.108.90;rport=5060;branch=z9hG4bKSB3686SccK99e
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513896 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:19.513692 [DEBUG] sofia.c:7084 Channel sofia/internal/safarov@servpac.com entering state [received][100]
2018-03-22 06:25:19.513692 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=Servpac 1521675148 1521675150 IN IP4 207.2.108.90
s=Servpac
c=IN IP4 207.2.108.90
t=0 0
m=image 24768 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxFillBitRemoval
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:2000
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
2018-03-22 06:25:19.513692 [DEBUG] switch_core_media.c:4041 sofia/internal/safarov@servpac.com T38 ACCEPT on request
2018-03-22 06:25:19.513692 [DEBUG] switch_core_media.c:4098 Audio params are unchanged for sofia/internal/safarov@servpac.com.
2018-03-22 06:25:19.513692 [DEBUG] switch_core_media.c:4131 Passing T38 req to other leg.
v=0
o=Servpac 1521675148 1521675150 IN IP4 207.2.108.90
s=Servpac
c=IN IP4 207.2.108.90
t=0 0
m=image 24768 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxFillBitRemoval
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:2000
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
2018-03-22 06:25:19.513692 [DEBUG] switch_core_media.c:4146 sofia/internal/safarov@servpac.com T38 IS POSSIBLE on request
2018-03-22 06:25:19.524033 [DEBUG] switch_core_media.c:9390 sofia/internal/1003@207.2.108.149 image media sdp:
v=0
o=FreeSWITCH 1521678050 1521678052 IN IP4 217.12.247.212
s=FreeSWITCH
c=IN IP4 217.12.247.212
t=0 0
m=image 21866 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxFillBitRemoval
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:2000
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
2018-03-22 06:25:19.524033 [DEBUG] sofia_glue.c:1295 sofia/internal/1003@207.2.108.149 sending invite version: 1.6.20+git git b46d864 2018-01-27 11:52:21Z 64bit
Local SDP:
v=0
o=FreeSWITCH 1521678050 1521678052 IN IP4 217.12.247.212
s=FreeSWITCH
c=IN IP4 217.12.247.212
t=0 0
m=image 21866 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxFillBitRemoval
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:2000
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
send 1087 bytes to udp/[207.2.108.149]:5060 at 06:25:19.539767:
------------------------------------------------------------------------
INVITE sip:207.2.108.149 SIP/2.0
Via: SIP/2.0/UDP 217.12.247.212;rport;branch=z9hG4bKU2Xj41Ht5jZZj
Max-Forwards: 69
From: "" <sip:safarov@servpac.com>;tag=meHtjDFFvH8Zr
To: <sip:1003@207.2.108.149>;tag=ad080630-0-13c4-55013-31073c-7a6207fe-31073c
Call-ID: a0bdeff6-a83c-1236-dc98-000c296ca80b
CSeq: 120513895 INVITE
Contact: <sip:mod_sofia@217.12.247.212:5060>
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Content-Type: application/sdp
Content-Length: 320
X-FS-Support: update_display,send_info
Remote-Party-ID: <sip:safarov@servpac.com>;party=calling;screen=yes;privacy=off
v=0
o=FreeSWITCH 1521678050 1521678052 IN IP4 217.12.247.212
s=FreeSWITCH
c=IN IP4 217.12.247.212
t=0 0
m=image 21866 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxFillBitRemoval
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:2000
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
------------------------------------------------------------------------
2018-03-22 06:25:19.524033 [DEBUG] sofia.c:7084 Channel sofia/internal/1003@207.2.108.149 entering state [calling][0]
recv 724 bytes from udp/[207.2.108.149]:5060 at 06:25:19.788820:
------------------------------------------------------------------------
SIP/2.0 200 OK
From: ""<sip:safarov@servpac.com>;tag=meHtjDFFvH8Zr
To: <sip:1003@207.2.108.149>;tag=ad080630-0-13c4-55013-31073c-7a6207fe-31073c
Call-ID: a0bdeff6-a83c-1236-dc98-000c296ca80b
CSeq: 120513895 INVITE
Via: SIP/2.0/UDP 217.12.247.212;rport=5060;branch=z9hG4bKU2Xj41Ht5jZZj
Supported: 100rel
User-Agent: Brktsip/6.7.1B3 (Dialogic)
Contact: <sip:207.2.108.149>
Content-Type: application/sdp
Content-Length: 290
v=0
o=- 2212201942 0632133000 IN IP4 207.2.108.149
s=no_session_name
t=0 0
m=image 56056 udptl t38
c=IN IP4 207.2.108.149
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:8192
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
------------------------------------------------------------------------
2018-03-22 06:25:19.793698 [DEBUG] switch_core_media.c:6269 Remote address:port [207.2.108.149:56056] has not changed.
2018-03-22 06:25:19.793698 [DEBUG] sofia.c:6654 Passing 200 OK to other leg
v=0
o=- 2212201942 0632133000 IN IP4 207.2.108.149
s=no_session_name
t=0 0
m=image 56056 udptl t38
c=IN IP4 207.2.108.149
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:8192
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
2018-03-22 06:25:19.793698 [DEBUG] switch_core_media.c:653 Audio params are unchanged for sofia/internal/1003@207.2.108.149.
2018-03-22 06:25:19.793698 [INFO] sofia.c:6704 Activating T38 Passthru
2018-03-22 06:25:19.793698 [DEBUG] sofia.c:7084 Channel sofia/internal/1003@207.2.108.149 entering state [completing][200]
2018-03-22 06:25:19.793698 [DEBUG] sofia.c:7091 Duplicate SDP
v=0
o=- 2212201942 0632133000 IN IP4 207.2.108.149
s=no_session_name
t=0 0
m=image 56056 udptl t38
c=IN IP4 207.2.108.149
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:8192
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
2018-03-22 06:25:19.793698 [DEBUG] mod_sofia.c:2132 Responding with 200 [OK]
2018-03-22 06:25:19.793698 [DEBUG] switch_core_media.c:9390 sofia/internal/safarov@servpac.com image media sdp:
v=0
o=FreeSWITCH 1521683104 1521683106 IN IP4 217.12.247.212
s=FreeSWITCH
c=IN IP4 217.12.247.212
t=0 0
m=image 16812 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxFillBitRemoval
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:8192
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
send 384 bytes to udp/[207.2.108.149]:5060 at 06:25:19.800964:
------------------------------------------------------------------------
ACK sip:207.2.108.149 SIP/2.0
Via: SIP/2.0/UDP 217.12.247.212;rport;branch=z9hG4bKvBQB6v2X2UNje
Max-Forwards: 70
From: "" <sip:safarov@servpac.com>;tag=meHtjDFFvH8Zr
To: <sip:1003@207.2.108.149>;tag=ad080630-0-13c4-55013-31073c-7a6207fe-31073c
Call-ID: a0bdeff6-a83c-1236-dc98-000c296ca80b
CSeq: 120513895 ACK
Contact: <sip:mod_sofia@217.12.247.212:5060>
Content-Length: 0
------------------------------------------------------------------------
send 986 bytes to udp/[207.2.108.90]:5060 at 06:25:19.801142:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 207.2.108.90;rport=5060;branch=z9hG4bKSB3686SccK99e
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513896 INVITE
Contact: <sip:1003@217.12.247.212:5060;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 342
v=0
o=FreeSWITCH 1521683104 1521683106 IN IP4 217.12.247.212
s=FreeSWITCH
c=IN IP4 217.12.247.212
t=0 0
m=image 16812 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxFillBitRemoval
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:8192
a=T38FaxMaxDatagram:400
a=T38FaxUdpEC:t38UDPRedundancy
m=video 0 RTP/AVP 19
------------------------------------------------------------------------
2018-03-22 06:25:19.793698 [DEBUG] sofia.c:7084 Channel sofia/internal/1003@207.2.108.149 entering state [ready][200]
2018-03-22 06:25:19.793698 [DEBUG] switch_core_media.c:4041 sofia/internal/1003@207.2.108.149 T38 ACCEPT on response
2018-03-22 06:25:19.793698 [DEBUG] switch_core_media.c:4146 sofia/internal/1003@207.2.108.149 T38 IS POSSIBLE on response
2018-03-22 06:25:19.793698 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/internal/1003@207.2.108.149.
2018-03-22 06:25:19.793698 [DEBUG] sofia.c:7084 Channel sofia/internal/safarov@servpac.com entering state [completed][200]
recv 653 bytes from udp/[207.2.108.90]:5060 at 06:25:20.054980:
------------------------------------------------------------------------
ACK sip:1003@217.12.247.212:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 207.2.108.90;rport;branch=z9hG4bKtmvZa2ag9UZva
Max-Forwards: 70
From: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
To: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513896 ACK
Contact: <sip:mod_sofia@207.2.108.90:5060>
Proxy-Authorization: Digest username="safarov", realm="servpac.com", nonce="570edbb0-eeb7-4511-9501-daa59b8b4c1a", cnonce="oO3Noag8Ejax9ABQVqFxWg", algorithm=MD5, uri="sip:1003@217.12.247.212:5060;transport=udp", response="d7161ca89deab825343e457099121ec3", qop=auth, nc=00000002
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:20.053701 [DEBUG] sofia.c:7084 Channel sofia/internal/safarov@servpac.com entering state [ready][200]
2018-03-22 06:25:21.333695 [DEBUG] switch_rtp.c:6758 Correct video RTCP ip/port confirmed.
recv 414 bytes from udp/[207.2.108.149]:5060 at 06:25:35.966503:
------------------------------------------------------------------------
BYE sip:mod_sofia@217.12.247.212:5060 SIP/2.0
From: <sip:1003@207.2.108.149>;tag=ad080630-0-13c4-55013-31073c-7a6207fe-31073c
To: ""<sip:safarov@servpac.com>;tag=meHtjDFFvH8Zr
Call-ID: a0bdeff6-a83c-1236-dc98-000c296ca80b
CSeq: 1 BYE
Via: SIP/2.0/UDP 207.2.108.149:5060;branch=z9hG4bK-31074f-bf848f40-58a38678
Supported: 100rel
Max-Forwards: 70
User-Agent: Brktsip/6.7.1B3 (Dialogic)
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:35.963684 [NOTICE] sofia.c:1012 Hangup sofia/internal/1003@207.2.108.149 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
2018-03-22 06:25:35.963684 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/internal/1003@207.2.108.149]
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/1003@207.2.108.149) State EXCHANGE_MEDIA going to sleep
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@207.2.108.149) Running State Change CS_HANGUP (Cur 2 Tot 106)
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1003@207.2.108.149) Callstate Change ACTIVE -> HANGUP
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1003@207.2.108.149) State HANGUP
2018-03-22 06:25:35.963684 [DEBUG] mod_sofia.c:438 Channel sofia/internal/1003@207.2.108.149 hanging up, cause: NORMAL_CLEARING
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1003@207.2.108.149 Standard HANGUP, cause: NORMAL_CLEARING
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1003@207.2.108.149) State HANGUP going to sleep
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1003@207.2.108.149) State Change CS_HANGUP -> CS_REPORTING
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1003@207.2.108.149) Running State Change CS_REPORTING (Cur 2 Tot 106)
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1003@207.2.108.149) State REPORTING
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1003@207.2.108.149 Standard REPORTING, cause: NORMAL_CLEARING
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1003@207.2.108.149) State REPORTING going to sleep
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1003@207.2.108.149) State Change CS_REPORTING -> CS_DESTROY
2018-03-22 06:25:35.963684 [DEBUG] switch_core_session.c:1665 Session 106 (sofia/internal/1003@207.2.108.149) Locked, Waiting on external entities
2018-03-22 06:25:35.963684 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/internal/safarov@servpac.com]
2018-03-22 06:25:35.963684 [NOTICE] switch_core_state_machine.c:385 sofia/internal/safarov@servpac.com has executed the last dialplan instruction, hanging up.
2018-03-22 06:25:35.963684 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/internal/safarov@servpac.com [CS_EXECUTE] [NORMAL_CLEARING]
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/safarov@servpac.com) State EXECUTE going to sleep
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/safarov@servpac.com) Running State Change CS_HANGUP (Cur 2 Tot 106)
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/safarov@servpac.com) Callstate Change ACTIVE -> HANGUP
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/safarov@servpac.com) State HANGUP
2018-03-22 06:25:35.963684 [DEBUG] mod_sofia.c:432 sofia/internal/safarov@servpac.com Overriding SIP cause 480 with 200 from the other leg
2018-03-22 06:25:35.963684 [DEBUG] mod_sofia.c:438 Channel sofia/internal/safarov@servpac.com hanging up, cause: NORMAL_CLEARING
2018-03-22 06:25:35.963684 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/internal/safarov@servpac.com
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:60 sofia/internal/safarov@servpac.com Standard HANGUP, cause: NORMAL_CLEARING
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/safarov@servpac.com) State HANGUP going to sleep
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/safarov@servpac.com) State Change CS_HANGUP -> CS_REPORTING
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/safarov@servpac.com) Running State Change CS_REPORTING (Cur 2 Tot 106)
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/safarov@servpac.com) State REPORTING
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:174 sofia/internal/safarov@servpac.com Standard REPORTING, cause: NORMAL_CLEARING
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/safarov@servpac.com) State REPORTING going to sleep
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/safarov@servpac.com) State Change CS_REPORTING -> CS_DESTROY
2018-03-22 06:25:35.963684 [DEBUG] switch_core_session.c:1665 Session 105 (sofia/internal/safarov@servpac.com) Locked, Waiting on external entities
send 529 bytes to udp/[207.2.108.149]:5060 at 06:25:35.970198:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 207.2.108.149:5060;branch=z9hG4bK-31074f-bf848f40-58a38678
From: <sip:1003@207.2.108.149>;tag=ad080630-0-13c4-55013-31073c-7a6207fe-31073c
To: ""<sip:safarov@servpac.com>;tag=meHtjDFFvH8Zr
Call-ID: a0bdeff6-a83c-1236-dc98-000c296ca80b
CSeq: 1 BYE
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Content-Length: 0
------------------------------------------------------------------------
send 589 bytes to udp/[207.2.108.90]:5060 at 06:25:35.970313:
------------------------------------------------------------------------
BYE sip:mod_sofia@207.2.108.90:5060 SIP/2.0
Via: SIP/2.0/UDP 217.12.247.212;rport;branch=z9hG4bKXmg47QK1Z4B5S
Max-Forwards: 70
From: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
To: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513895 BYE
User-Agent: FreeSWITCH-mod_sofia/1.6.20+git-20180127T115221Z~b46d864f14~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Reason: Q.850;cause=16;text="NORMAL_CLEARING"
Content-Length: 0
------------------------------------------------------------------------
2018-03-22 06:25:35.963684 [NOTICE] switch_core_session.c:1683 Session 106 (sofia/internal/1003@207.2.108.149) Ended
2018-03-22 06:25:35.963684 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/1003@207.2.108.149 [CS_DESTROY]
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1003@207.2.108.149) Running State Change CS_DESTROY (Cur 1 Tot 106)
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1003@207.2.108.149) State DESTROY
2018-03-22 06:25:35.963684 [DEBUG] mod_sofia.c:343 sofia/internal/1003@207.2.108.149 SOFIA DESTROY
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1003@207.2.108.149 Standard DESTROY
2018-03-22 06:25:35.963684 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1003@207.2.108.149) State DESTROY going to sleep
2018-03-22 06:25:35.973695 [DEBUG] switch_core_media.c:5970 sofia/internal/safarov@servpac.com Video thread ended
2018-03-22 06:25:35.973695 [NOTICE] switch_core_session.c:1683 Session 105 (sofia/internal/safarov@servpac.com) Ended
2018-03-22 06:25:35.973695 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/safarov@servpac.com [CS_DESTROY]
2018-03-22 06:25:35.973695 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/safarov@servpac.com) Running State Change CS_DESTROY (Cur 0 Tot 106)
2018-03-22 06:25:35.973695 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/safarov@servpac.com) State DESTROY
2018-03-22 06:25:35.973695 [DEBUG] mod_sofia.c:343 sofia/internal/safarov@servpac.com SOFIA DESTROY
2018-03-22 06:25:35.973695 [DEBUG] mod_opus.c:711 Opus decoder stats: Frames[97] PLC[0] FEC[0]
2018-03-22 06:25:35.973695 [DEBUG] mod_opus.c:726 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
2018-03-22 06:25:35.973695 [DEBUG] mod_opus.c:711 Opus decoder stats: Frames[0] PLC[0] FEC[0]
2018-03-22 06:25:35.973695 [DEBUG] mod_opus.c:726 Opus encoder stats: Frames[139] Bytes encoded[17652] Encoded length ms[2780] Average encoded bitrate bps[70608]
2018-03-22 06:25:35.973695 [DEBUG] switch_core_state_machine.c:181 sofia/internal/safarov@servpac.com Standard DESTROY
2018-03-22 06:25:35.973695 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/safarov@servpac.com) State DESTROY going to sleep
recv 450 bytes from udp/[207.2.108.90]:5060 at 06:25:36.216452:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 217.12.247.212;rport=5060;branch=z9hG4bKXmg47QK1Z4B5S
From: <sip:1003@servpac.com>;tag=K5Q1gjyBZ8HDD
To: "" <sip:safarov@servpac.com>;tag=NHNN61Ua9vX0N
Call-ID: a0c74d0a-a83c-1236-f4b1-005056a1715a
CSeq: 120513895 BYE
User-Agent: Servpac VOIP v5
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Content-Length: 0
------------------------------------------------------------------------
freeswitch@node2.docker.rcsnet.ru>
freeswitch@node2.docker.rcsnet.ru>
freeswitch@node2.docker.rcsnet.ru>