- freeswitch@freeswitch-test> originate {ignore_early_media=true,origination_caller_id_number=13342120202}sofia/gateway/flowroute/13342120101 &txfax(/tmp/txfax-sample.tiff)
- +OK 1e8b620e-426a-44ba-ab13-862043c77fe4
- 2017-05-11 15:15:16.749601 [DEBUG] switch_ivr_originate.c:2147 Parsing global variables
- 2017-05-11 15:15:16.749601 [NOTICE] switch_channel.c:1104 New Channel sofia/external/13342120101 [1e8b620e-426a-44ba-ab13-862043c77fe4]
- 2017-05-11 15:15:16.749601 [DEBUG] mod_sofia.c:5026 (sofia/external/13342120101) State Change CS_NEW -> CS_INIT
- 2017-05-11 15:15:16.749601 [DEBUG] switch_core_state_machine.c:584 (sofia/external/13342120101) Running State Change CS_INIT (Cur 1 Tot 125)
- 2017-05-11 15:15:16.749601 [DEBUG] switch_core_state_machine.c:627 (sofia/external/13342120101) State INIT
- 2017-05-11 15:15:16.749601 [DEBUG] mod_sofia.c:93 sofia/external/13342120101 SOFIA INIT
- 2017-05-11 15:15:16.749601 [DEBUG] sofia_glue.c:1298 sofia/external/13342120101 sending invite version: 1.9.0 git 5d4ac1c 2017-05-05 16:19:17Z 64bit
- Local SDP:
- v=0
- o=FreeSWITCH 1494501984 1494501985 IN IP4 192.168.1.9
- s=FreeSWITCH
- c=IN IP4 192.168.1.9
- t=0 0
- m=audio 28132 RTP/AVP 102 9 0 8 105 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:105 telephone-event/48000
- a=fmtp:105 0-16
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- a=sendrecv
- m=video 23772 RTP/AVP 103 104 34
- b=AS:1024
- a=rtpmap:103 VP8/90000
- a=rtpmap:104 H264/90000
- a=rtpmap:34 H263/90000
- a=sendrecv
- a=rtcp-fb:103 ccm fir
- a=rtcp-fb:103 ccm tmmbr
- a=rtcp-fb:103 nack
- a=rtcp-fb:103 nack pli
- a=rtcp-fb:104 ccm fir
- a=rtcp-fb:104 ccm tmmbr
- a=rtcp-fb:104 nack
- a=rtcp-fb:104 nack pli
- a=rtcp-fb:34 ccm fir
- a=rtcp-fb:34 ccm tmmbr
- a=rtcp-fb:34 nack
- a=rtcp-fb:34 nack pli
- 2017-05-11 15:15:16.749601 [DEBUG] switch_core_state_machine.c:40 sofia/external/13342120101 Standard INIT
- 2017-05-11 15:15:16.749601 [DEBUG] switch_core_state_machine.c:48 (sofia/external/13342120101) State Change CS_INIT -> CS_ROUTING
- 2017-05-11 15:15:16.749601 [DEBUG] switch_core_state_machine.c:627 (sofia/external/13342120101) State INIT going to sleep
- 2017-05-11 15:15:16.749601 [DEBUG] switch_core_state_machine.c:584 (sofia/external/13342120101) Running State Change CS_ROUTING (Cur 1 Tot 125)
- 2017-05-11 15:15:16.749601 [DEBUG] switch_core_state_machine.c:643 (sofia/external/13342120101) State ROUTING
- 2017-05-11 15:15:16.749601 [DEBUG] mod_sofia.c:154 sofia/external/13342120101 SOFIA ROUTING
- 2017-05-11 15:15:16.749601 [DEBUG] switch_ivr_originate.c:67 (sofia/external/13342120101) State Change CS_ROUTING -> CS_CONSUME_MEDIA
- 2017-05-11 15:15:16.749601 [DEBUG] switch_core_state_machine.c:643 (sofia/external/13342120101) State ROUTING going to sleep
- 2017-05-11 15:15:16.749601 [DEBUG] switch_core_state_machine.c:584 (sofia/external/13342120101) Running State Change CS_CONSUME_MEDIA (Cur 1 Tot 125)
- send 1700 bytes to udp/[216.115.69.144]:5060 at 15:15:15.435596:
- ------------------------------------------------------------------------
- INVITE sip:13342120101@sip.flowroute.com SIP/2.0
- Via: SIP/2.0/UDP 192.168.1.9:5080;rport;branch=z9hG4bKF1vXvpjXpH7pe
- Max-Forwards: 70
- From: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- To: <sip:13342120101@sip.flowroute.com>
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 106928993 INVITE
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, refer
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 855
- X-FS-Support: update_display,send_info
- Remote-Party-ID: <sip:13342120202@sip.flowroute.com>;party=calling;screen=yes;privacy=off
- v=0
- o=FreeSWITCH 1494501984 1494501985 IN IP4 192.168.1.9
- s=FreeSWITCH
- c=IN IP4 192.168.1.9
- t=0 0
- m=audio 28132 RTP/AVP 102 9 0 8 105 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:105 telephone-event/48000
- a=fmtp:105 0-16
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- m=video 23772 RTP/AVP 103 104 34
- b=AS:1024
- a=rtpmap:103 VP8/90000
- a=rtpmap:104 H264/90000
- a=rtpmap:34 H263/90000
- a=rtcp-fb:103 ccm fir
- a=rtcp-fb:103 ccm tmmbr
- a=rtcp-fb:103 nack
- a=rtcp-fb:103 nack pli
- a=rtcp-fb:104 ccm fir
- a=rtcp-fb:104 ccm tmmbr
- a=rtcp-fb:104 nack
- a=rtcp-fb:104 nack pli
- a=rtcp-fb:34 ccm fir
- a=rtcp-fb:34 ccm tmmbr
- a=rtcp-fb:34 nack
- a=rtcp-fb:34 nack pli
- ------------------------------------------------------------------------
- 2017-05-11 15:15:16.768624 [DEBUG] switch_core_state_machine.c:662 (sofia/external/13342120101) State CONSUME_MEDIA
- 2017-05-11 15:15:16.768624 [DEBUG] switch_core_state_machine.c:662 (sofia/external/13342120101) State CONSUME_MEDIA going to sleep
- 2017-05-11 15:15:16.768624 [DEBUG] sofia.c:7247 Channel sofia/external/13342120101 entering state [calling][0]
- recv 312 bytes from udp/[216.115.69.144]:5060 at 15:15:15.578778:
- ------------------------------------------------------------------------
- SIP/2.0 100 Trying
- Via: SIP/2.0/UDP 192.168.1.9:5080;rport=5080;branch=z9hG4bKF1vXvpjXpH7pe;received=68.157.150.128
- From: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- To: <sip:13342120101@sip.flowroute.com>
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 106928993 INVITE
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 485 bytes from udp/[216.115.69.144]:5060 at 15:15:15.625228:
- ------------------------------------------------------------------------
- SIP/2.0 407 Proxy Authentication Required
- Via: SIP/2.0/UDP 192.168.1.9:5080;received=68.157.150.128;rport=5080;branch=z9hG4bKF1vXvpjXpH7pe
- From: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- To: <sip:13342120101@sip.flowroute.com>;tag=870a5b262384e4f9f82f59836d699db5.b95b
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 106928993 INVITE
- Proxy-Authenticate: Digest realm="sip.flowroute.com", nonce="WRS5b1kUuEN/adTD6CuWvpqXwB8IjeFy", qop="auth"
- Content-Length: 0
- ------------------------------------------------------------------------
- send 367 bytes to udp/[216.115.69.144]:5060 at 15:15:15.625355:
- ------------------------------------------------------------------------
- ACK sip:13342120101@sip.flowroute.com SIP/2.0
- Via: SIP/2.0/UDP 192.168.1.9:5080;rport;branch=z9hG4bKF1vXvpjXpH7pe
- Max-Forwards: 70
- From: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- To: <sip:13342120101@sip.flowroute.com>;tag=870a5b262384e4f9f82f59836d699db5.b95b
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 106928993 ACK
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1975 bytes to udp/[216.115.69.144]:5060 at 15:15:15.625782:
- ------------------------------------------------------------------------
- INVITE sip:13342120101@sip.flowroute.com SIP/2.0
- Via: SIP/2.0/UDP 192.168.1.9:5080;rport;branch=z9hG4bKgappyH30KtX9S
- Max-Forwards: 70
- From: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- To: <sip:13342120101@sip.flowroute.com>
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 106928994 INVITE
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, refer
- Proxy-Authorization: Digest username="28308479", realm="sip.flowroute.com", nonce="WRS5b1kUuEN/adTD6CuWvpqXwB8IjeFy", cnonce="AVpTnbEhEjWe0wgAJ3evvg", algorithm=MD5, uri="sip:13342120101@sip.flowroute.com", response="6684a94d055d89e1cca692ab87e86933", qop=auth, nc=00000001
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 855
- X-FS-Support: update_display,send_info
- Remote-Party-ID: <sip:13342120202@sip.flowroute.com>;party=calling;screen=yes;privacy=off
- v=0
- o=FreeSWITCH 1494501984 1494501985 IN IP4 192.168.1.9
- s=FreeSWITCH
- c=IN IP4 192.168.1.9
- t=0 0
- m=audio 28132 RTP/AVP 102 9 0 8 105 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:105 telephone-event/48000
- a=fmtp:105 0-16
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- m=video 23772 RTP/AVP 103 104 34
- b=AS:1024
- a=rtpmap:103 VP8/90000
- a=rtpmap:104 H264/90000
- a=rtpmap:34 H263/90000
- a=rtcp-fb:103 ccm fir
- a=rtcp-fb:103 ccm tmmbr
- a=rtcp-fb:103 nack
- a=rtcp-fb:103 nack pli
- a=rtcp-fb:104 ccm fir
- a=rtcp-fb:104 ccm tmmbr
- a=rtcp-fb:104 nack
- a=rtcp-fb:104 nack pli
- a=rtcp-fb:34 ccm fir
- a=rtcp-fb:34 ccm tmmbr
- a=rtcp-fb:34 nack
- a=rtcp-fb:34 nack pli
- ------------------------------------------------------------------------
- 2017-05-11 15:15:16.949177 [DEBUG] sofia.c:7247 Channel sofia/external/13342120101 entering state [calling][0]
- recv 312 bytes from udp/[216.115.69.144]:5060 at 15:15:15.792413:
- ------------------------------------------------------------------------
- SIP/2.0 100 Trying
- Via: SIP/2.0/UDP 192.168.1.9:5080;rport=5080;branch=z9hG4bKgappyH30KtX9S;received=68.157.150.128
- From: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- To: <sip:13342120101@sip.flowroute.com>
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 106928994 INVITE
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 496 bytes from udp/[216.115.69.144]:5060 at 15:15:20.611897:
- ------------------------------------------------------------------------
- OPTIONS sip:68.157.150.128:5080;transport=udp SIP/2.0
- Max-Forwards: 10
- Record-Route: <sip:216.115.69.144;lr>
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK5853.7bfee1e475e7cc412b84b42c8bd2c972.0
- Via: SIP/2.0/UDP 216.115.69.131:5060;branch=0
- Route: <sip:216.115.69.144;lr;received='sip:68.157.150.128:5080;transport=udp'>
- From: sip:ping@invalid;tag=5b2a14e5
- To: sip:68.157.150.128:5080;transport=udp
- Call-ID: 84599eb4-4c8c7c47-c61d9c2@216.115.69.131
- CSeq: 1 OPTIONS
- Content-Length: 0
- ------------------------------------------------------------------------
- send 723 bytes to udp/[216.115.69.144]:5060 at 15:15:20.612601:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK5853.7bfee1e475e7cc412b84b42c8bd2c972.0
- Via: SIP/2.0/UDP 216.115.69.131:5060;branch=0
- Record-Route: <sip:216.115.69.144;lr>
- From: sip:ping@invalid;tag=5b2a14e5
- To: <sip:68.157.150.128:5080>;transport=udp;tag=0r4QKDpj6pQmj
- Call-ID: 84599eb4-4c8c7c47-c61d9c2@216.115.69.131
- CSeq: 1 OPTIONS
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 1089 bytes from udp/[216.115.69.144]:5060 at 15:15:22.673682:
- ------------------------------------------------------------------------
- INVITE sip:13342120101@192.168.1.9:5080;transport=udp SIP/2.0
- Record-Route: <sip:216.115.69.144;lr>
- From: "LINDEN AL" <sip:+13342120202@fl.gg>;tag=gK0c300052
- Max-Forwards: 66
- Record-Route: <sip:216.115.69.132;lr>
- To: <sip:+13342120101@fl.gg>
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bKde3d.b6abe1765ca3337723754c0aceab93ec.0
- Via: SIP/2.0/UDP 216.115.69.131;branch=z9hG4bKde3d.3b36e9596ae94e3d90f7a8cdd95fc2b3.1
- Via: SIP/2.0/UDP 216.115.69.132;branch=z9hG4bKde3d.a66297e5adbd5bdfc0293963ead47325.0
- Via: SIP/2.0/UDP 74.120.93.200:5060;branch=z9hG4bK0cB2b5717fe78101b1f
- Call-ID: 522992438_133801219@74.120.93.200
- CSeq: 85750 INVITE
- Contact: "3342120202" <sip:+13342120202@74.120.93.200:5060>
- Session-Expires: 1800
- Min-SE: 90
- Content-Length: 222
- Content-Type: application/sdp
- P-Asserted-Identity: "LINDEN AL" <sip:+13342120202@fl.gg>
- v=0
- o=- 54431 302410 IN IP4 74.120.93.202
- s=-
- c=IN IP4 74.120.93.202
- t=0 0
- m=audio 45992 RTP/AVP 0 8 18 101
- a=rtpmap:18 G729/8000
- a=fmtp:18 annexb=no
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-15
- a=ptime:20
- ------------------------------------------------------------------------
- 2017-05-11 15:15:23.989005 [NOTICE] switch_channel.c:1104 New Channel sofia/external/+13342120202@fl.gg [6314b885-19e6-40fb-b20e-4e099422bbe4]
- 2017-05-11 15:15:23.989005 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+13342120202@fl.gg) Running State Change CS_NEW (Cur 2 Tot 126)
- 2017-05-11 15:15:23.989005 [DEBUG] sofia.c:10028 sofia/external/+13342120202@fl.gg receiving invite from 216.115.69.144:5060 version: 1.9.0 git 5d4ac1c 2017-05-05 16:19:17Z 64bit
- 2017-05-11 15:15:23.989005 [DEBUG] sofia.c:7247 Channel sofia/external/+13342120202@fl.gg entering state [received][100]
- 2017-05-11 15:15:23.989005 [DEBUG] sofia.c:7257 Remote SDP:
- v=0
- o=- 54431 302410 IN IP4 74.120.93.202
- s=-
- c=IN IP4 74.120.93.202
- t=0 0
- m=audio 45992 RTP/AVP 0 8 18 101
- a=rtpmap:18 G729/8000
- a=fmtp:18 annexb=no
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-15
- a=ptime:20
- 2017-05-11 15:15:23.989005 [DEBUG] sofia.c:7649 (sofia/external/+13342120202@fl.gg) State Change CS_NEW -> CS_INIT
- 2017-05-11 15:15:23.989005 [DEBUG] switch_core_state_machine.c:603 (sofia/external/+13342120202@fl.gg) State NEW
- 2017-05-11 15:15:23.989005 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+13342120202@fl.gg) Running State Change CS_INIT (Cur 2 Tot 126)
- 2017-05-11 15:15:23.989005 [DEBUG] switch_core_state_machine.c:627 (sofia/external/+13342120202@fl.gg) State INIT
- 2017-05-11 15:15:23.989005 [DEBUG] mod_sofia.c:93 sofia/external/+13342120202@fl.gg SOFIA INIT
- 2017-05-11 15:15:23.989005 [DEBUG] switch_core_state_machine.c:40 sofia/external/+13342120202@fl.gg Standard INIT
- 2017-05-11 15:15:23.989005 [DEBUG] switch_core_state_machine.c:48 (sofia/external/+13342120202@fl.gg) State Change CS_INIT -> CS_ROUTING
- 2017-05-11 15:15:23.989005 [DEBUG] switch_core_state_machine.c:627 (sofia/external/+13342120202@fl.gg) State INIT going to sleep
- 2017-05-11 15:15:23.989005 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+13342120202@fl.gg) Running State Change CS_ROUTING (Cur 2 Tot 126)
- 2017-05-11 15:15:23.989005 [DEBUG] switch_channel.c:2249 (sofia/external/+13342120202@fl.gg) Callstate Change DOWN -> RINGING
- 2017-05-11 15:15:23.989005 [DEBUG] switch_core_state_machine.c:643 (sofia/external/+13342120202@fl.gg) State ROUTING
- 2017-05-11 15:15:23.989005 [DEBUG] mod_sofia.c:154 sofia/external/+13342120202@fl.gg SOFIA ROUTING
- 2017-05-11 15:15:23.989005 [DEBUG] switch_core_state_machine.c:236 sofia/external/+13342120202@fl.gg Standard ROUTING
- 2017-05-11 15:15:23.989005 [INFO] mod_dialplan_xml.c:637 Processing LINDEN AL <+13342120202>->13342120101 in context public
- send 365 bytes to udp/[216.115.69.144]:5060 at 15:15:22.675349:
- ------------------------------------------------------------------------
- SIP/2.0 100 Trying
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bKde3d.b6abe1765ca3337723754c0aceab93ec.0
- From: "LINDEN AL" <sip:+13342120202@fl.gg>;tag=gK0c300052
- To: <sip:+13342120101@fl.gg>
- Call-ID: 522992438_133801219@74.120.93.200
- CSeq: 85750 INVITE
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Content-Length: 0
- ------------------------------------------------------------------------
- Dialplan: sofia/external/+13342120202@fl.gg parsing [public->unloop] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [public->outside_call] continue=true
- Dialplan: sofia/external/+13342120202@fl.gg Absolute Condition [outside_call]
- Dialplan: sofia/external/+13342120202@fl.gg Action set(outside_call=true)
- Dialplan: sofia/external/+13342120202@fl.gg Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
- Dialplan: sofia/external/+13342120202@fl.gg parsing [public->call_debug] continue=true
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
- Dialplan: sofia/external/+13342120202@fl.gg parsing [public->public_extensions] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [public_extensions] destination_number(13342120101) =~ /^(10[01][0-9]|35\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [public->did 0101] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (PASS) [did 0101] destination_number(13342120101) =~ /^(\+?1?3342120101)$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg Action set(domain_name=192.168.1.9)
- Dialplan: sofia/external/+13342120202@fl.gg Action transfer(9178 XML default)
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:286 (sofia/external/+13342120202@fl.gg) State Change CS_ROUTING -> CS_EXECUTE
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:643 (sofia/external/+13342120202@fl.gg) State ROUTING going to sleep
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+13342120202@fl.gg) Running State Change CS_EXECUTE (Cur 2 Tot 126)
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:650 (sofia/external/+13342120202@fl.gg) State EXECUTE
- 2017-05-11 15:15:24.008697 [DEBUG] mod_sofia.c:209 sofia/external/+13342120202@fl.gg SOFIA EXECUTE
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:328 sofia/external/+13342120202@fl.gg Standard EXECUTE
- EXECUTE sofia/external/+13342120202@fl.gg set(outside_call=true)
- 2017-05-11 15:15:24.008697 [DEBUG] mod_dptools.c:1570 SET sofia/external/+13342120202@fl.gg [outside_call]=[true]
- EXECUTE sofia/external/+13342120202@fl.gg export(RFC2822_DATE=Thu, 11 May 2017 15:15:24 -0400)
- 2017-05-11 15:15:24.008697 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Thu, 11 May 2017 15:15:24 -0400]
- EXECUTE sofia/external/+13342120202@fl.gg set(domain_name=192.168.1.9)
- 2017-05-11 15:15:24.008697 [DEBUG] mod_dptools.c:1570 SET sofia/external/+13342120202@fl.gg [domain_name]=[192.168.1.9]
- EXECUTE sofia/external/+13342120202@fl.gg transfer(9178 XML default)
- 2017-05-11 15:15:24.008697 [DEBUG] switch_ivr.c:2194 (sofia/external/+13342120202@fl.gg) State Change CS_EXECUTE -> CS_ROUTING
- 2017-05-11 15:15:24.008697 [NOTICE] switch_ivr.c:2201 Transfer sofia/external/+13342120202@fl.gg to XML[9178@default]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:650 (sofia/external/+13342120202@fl.gg) State EXECUTE going to sleep
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+13342120202@fl.gg) Running State Change CS_ROUTING (Cur 2 Tot 126)
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:643 (sofia/external/+13342120202@fl.gg) State ROUTING
- 2017-05-11 15:15:24.008697 [DEBUG] mod_sofia.c:145 Call appears to be already acknowledged
- 2017-05-11 15:15:24.008697 [DEBUG] mod_sofia.c:154 sofia/external/+13342120202@fl.gg SOFIA ROUTING
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:236 sofia/external/+13342120202@fl.gg Standard ROUTING
- 2017-05-11 15:15:24.008697 [INFO] mod_dialplan_xml.c:637 Processing LINDEN AL <+13342120202>->9178 in context default
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->dial-10-digit-number] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [dial-10-digit-number] destination_number(9178) =~ /^(1?\d{10})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->unloop] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->tod_example] continue=true
- Dialplan: sofia/external/+13342120202@fl.gg Date/Time Match (PASS) [tod_example] break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg Action set(open=true)
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->holiday_example] continue=true
- Dialplan: sofia/external/+13342120202@fl.gg Date/TimeMatch (FAIL) [holiday_example] break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->global-intercept] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [global-intercept] destination_number(9178) =~ /^886$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->group-intercept] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [group-intercept] destination_number(9178) =~ /^\*8$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->intercept-ext] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [intercept-ext] destination_number(9178) =~ /^\*\*(\d+)$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->redial] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [redial] destination_number(9178) =~ /^(redial|870)$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->global] continue=true
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [global] ${default_password}(j0sh3b0sh) =~ /^1234$/ break=never
- Dialplan: sofia/external/+13342120202@fl.gg 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
- Dialplan: sofia/external/+13342120202@fl.gg Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [global] ${switch_r_sdp}(v=0
- o=- 54431 302410 IN IP4 74.120.93.202
- s=-
- c=IN IP4 74.120.93.202
- t=0 0
- m=audio 45992 RTP/AVP 0 8 18 101
- a=rtpmap:18 G729/8000
- a=fmtp:18 annexb=no
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-15
- a=ptime:20
- ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
- Dialplan: sofia/external/+13342120202@fl.gg Absolute Condition [global]
- Dialplan: sofia/external/+13342120202@fl.gg Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
- Dialplan: sofia/external/+13342120202@fl.gg Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
- Dialplan: sofia/external/+13342120202@fl.gg Action hash(insert/${domain_name}-last_dial/global/${uuid})
- Dialplan: sofia/external/+13342120202@fl.gg Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->snom-demo-2] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [snom-demo-2] destination_number(9178) =~ /^9001$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->snom-demo-1] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [snom-demo-1] destination_number(9178) =~ /^9000$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->eavesdrop] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [eavesdrop] destination_number(9178) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->eavesdrop] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [eavesdrop] destination_number(9178) =~ /^779$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->call_return] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [call_return] destination_number(9178) =~ /^\*69$|^869$|^lcr$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->del-group] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [del-group] destination_number(9178) =~ /^80(\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->add-group] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [add-group] destination_number(9178) =~ /^81(\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->call-group-simo] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [call-group-simo] destination_number(9178) =~ /^82(\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->call-group-order] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [call-group-order] destination_number(9178) =~ /^83(\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->extension-intercom] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [extension-intercom] destination_number(9178) =~ /^8(10[01][0-9])$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->Local_Extension] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [Local_Extension] destination_number(9178) =~ /^(10[01][0-9])$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->Local_Extension_Skinny] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [Local_Extension_Skinny] destination_number(9178) =~ /^(11[01][0-9])$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->group_dial_sales] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [group_dial_sales] destination_number(9178) =~ /^2000$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->group_dial_support] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [group_dial_support] destination_number(9178) =~ /^2001$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->group_dial_billing] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [group_dial_billing] destination_number(9178) =~ /^2002$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->operator] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [operator] destination_number(9178) =~ /^(operator|0)$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->vmain] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [vmain] destination_number(9178) =~ /^vmain$|^4000$|^\*98$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->sip_uri] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [sip_uri] destination_number(9178) =~ /^sip:(.*)$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->nb_conferences] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [nb_conferences] destination_number(9178) =~ /^(30\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->wb_conferences] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [wb_conferences] destination_number(9178) =~ /^(31\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->uwb_conferences] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [uwb_conferences] destination_number(9178) =~ /^(32\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->cdquality_conferences] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [cdquality_conferences] destination_number(9178) =~ /^(33\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->cdquality_stereo_conferences] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [cdquality_stereo_conferences] destination_number(9178) =~ /^(35\d{2}).*?-screen$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->conference-canvases] continue=true
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [conference-canvases] destination_number(9178) =~ /(35\d{2})-canvas-(\d+)/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->conf mod] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [conf mod] destination_number(9178) =~ /^6070-moderator$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->cdquality_conferences] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [cdquality_conferences] destination_number(9178) =~ /^(35\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->freeswitch_public_conf_via_sip] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [freeswitch_public_conf_via_sip] destination_number(9178) =~ /^9(888|8888|1616|3232)$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->mad_boss_intercom] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [mad_boss_intercom] destination_number(9178) =~ /^0911$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->mad_boss_intercom] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [mad_boss_intercom] destination_number(9178) =~ /^0912$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->mad_boss] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [mad_boss] destination_number(9178) =~ /^0913$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->ivr_demo] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [ivr_demo] destination_number(9178) =~ /^5000$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->dynamic_conference] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [dynamic_conference] destination_number(9178) =~ /^5001$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->rtp_multicast_page] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [rtp_multicast_page] destination_number(9178) =~ /^pagegroup$|^7243$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->park] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [park] destination_number(9178) =~ /^5900$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->unpark] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [unpark] destination_number(9178) =~ /^5901$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->valet_park] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [valet_park] destination_number(9178) =~ /^(6000)$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->valet_park] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [valet_park] destination_number(9178) =~ /^((?!6000)60\d{2})$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->park] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [park] destination_number(9178) =~ /park\+(\d+)/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->unpark] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [unpark] destination_number(9178) =~ /^parking$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->park] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [park] destination_number(9178) =~ /callpark/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->unpark] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [unpark] destination_number(9178) =~ /pickup/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->wait] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (FAIL) [wait] destination_number(9178) =~ /^wait$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg parsing [default->fax_receive] continue=false
- Dialplan: sofia/external/+13342120202@fl.gg Regex (PASS) [fax_receive] destination_number(9178) =~ /^9178$/ break=on-false
- Dialplan: sofia/external/+13342120202@fl.gg Action answer()
- Dialplan: sofia/external/+13342120202@fl.gg Action playback(silence_stream://2000)
- Dialplan: sofia/external/+13342120202@fl.gg Action rxfax(/tmp/rxfax.tif)
- Dialplan: sofia/external/+13342120202@fl.gg Action hangup()
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:286 (sofia/external/+13342120202@fl.gg) State Change CS_ROUTING -> CS_EXECUTE
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:643 (sofia/external/+13342120202@fl.gg) State ROUTING going to sleep
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+13342120202@fl.gg) Running State Change CS_EXECUTE (Cur 2 Tot 126)
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:650 (sofia/external/+13342120202@fl.gg) State EXECUTE
- 2017-05-11 15:15:24.008697 [DEBUG] mod_sofia.c:209 sofia/external/+13342120202@fl.gg SOFIA EXECUTE
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_state_machine.c:328 sofia/external/+13342120202@fl.gg Standard EXECUTE
- EXECUTE sofia/external/+13342120202@fl.gg set(open=true)
- 2017-05-11 15:15:24.008697 [DEBUG] mod_dptools.c:1570 SET sofia/external/+13342120202@fl.gg [open]=[true]
- EXECUTE sofia/external/+13342120202@fl.gg hash(insert/192.168.1.9-spymap/+13342120202/6314b885-19e6-40fb-b20e-4e099422bbe4)
- EXECUTE sofia/external/+13342120202@fl.gg hash(insert/192.168.1.9-last_dial/+13342120202/9178)
- EXECUTE sofia/external/+13342120202@fl.gg hash(insert/192.168.1.9-last_dial/global/6314b885-19e6-40fb-b20e-4e099422bbe4)
- EXECUTE sofia/external/+13342120202@fl.gg export(RFC2822_DATE=Thu, 11 May 2017 15:15:24 -0400)
- 2017-05-11 15:15:24.008697 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Thu, 11 May 2017 15:15:24 -0400]
- EXECUTE sofia/external/+13342120202@fl.gg answer()
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5169 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5169 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5030 Set telephone-event payload to 101@8000
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:3425 Set Codec sofia/external/+13342120202@fl.gg PCMU/8000 20 ms 160 samples 64000 bits 1 channels
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_codec.c:111 sofia/external/+13342120202@fl.gg Original read codec set to PCMU:0
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5373 Set telephone-event payload to 101@8000
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:5431 sofia/external/+13342120202@fl.gg Set 2833 dtmf send payload to 101 recv payload to 101
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:8148 AUDIO RTP [sofia/external/+13342120202@fl.gg] 192.168.1.9 port 30352 -> 74.120.93.202 port 45992 codec: 0 ms: 20
- 2017-05-11 15:15:24.008697 [DEBUG] switch_rtp.c:4096 Starting timer [soft] 160 bytes per 20ms
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:8451 sofia/external/+13342120202@fl.gg Set 2833 dtmf send payload to 101
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:8458 sofia/external/+13342120202@fl.gg Set 2833 dtmf receive payload to 101
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:8481 sofia/external/+13342120202@fl.gg Set rtp dtmf delay to 40
- 2017-05-11 15:15:24.008697 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/+13342120202@fl.gg!
- 2017-05-11 15:15:24.008697 [DEBUG] switch_channel.c:3481 (sofia/external/+13342120202@fl.gg) Callstate Change RINGING -> EARLY
- 2017-05-11 15:15:24.008697 [DEBUG] switch_core_media.c:8131 Audio params are unchanged for sofia/external/+13342120202@fl.gg.
- 2017-05-11 15:15:24.008697 [DEBUG] mod_sofia.c:881 Local SDP sofia/external/+13342120202@fl.gg:
- v=0
- o=FreeSWITCH 1494499772 1494499773 IN IP4 192.168.1.9
- s=FreeSWITCH
- c=IN IP4 192.168.1.9
- t=0 0
- m=audio 30352 RTP/AVP 0 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- a=sendrecv
- 2017-05-11 15:15:24.008697 [NOTICE] mod_dptools.c:1352 Channel [sofia/external/+13342120202@fl.gg] has been answered
- 2017-05-11 15:15:24.008697 [DEBUG] switch_channel.c:3780 (sofia/external/+13342120202@fl.gg) Callstate Change EARLY -> ACTIVE
- send 1334 bytes to udp/[216.115.69.144]:5060 at 15:15:22.683627:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bKde3d.b6abe1765ca3337723754c0aceab93ec.0
- Via: SIP/2.0/UDP 216.115.69.131;branch=z9hG4bKde3d.3b36e9596ae94e3d90f7a8cdd95fc2b3.1
- Via: SIP/2.0/UDP 216.115.69.132;branch=z9hG4bKde3d.a66297e5adbd5bdfc0293963ead47325.0
- Via: SIP/2.0/UDP 74.120.93.200:5060;branch=z9hG4bK0cB2b5717fe78101b1f
- Record-Route: <sip:216.115.69.144;lr>
- Record-Route: <sip:216.115.69.132;lr>
- From: "LINDEN AL" <sip:+13342120202@fl.gg>;tag=gK0c300052
- To: <sip:+13342120101@fl.gg>;tag=11XgN86N3ZD7D
- Call-ID: 522992438_133801219@74.120.93.200
- CSeq: 85750 INVITE
- Contact: <sip:+13342120101@192.168.1.9:5080;transport=udp>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, refer
- Session-Expires: 1800;refresher=uas
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 218
- P-Asserted-Identity: "13342120101" <sip:13342120101@fl.gg>
- EXECUTE sofia/external/+13342120202@fl.gg playback(silence_stream://2000)
- v=0
- o=FreeSWITCH 1494499772 1494499773 IN IP4 192.168.1.9
- s=FreeSWITCH
- c=IN IP4 192.168.1.9
- t=0 0
- m=audio 30352 RTP/AVP 0 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- ------------------------------------------------------------------------
- 2017-05-11 15:15:24.008697 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
- 2017-05-11 15:15:24.008697 [DEBUG] sofia.c:7247 Channel sofia/external/+13342120202@fl.gg entering state [completed][200]
- recv 597 bytes from udp/[216.115.69.144]:5060 at 15:15:22.988713:
- ------------------------------------------------------------------------
- ACK sip:+13342120101@192.168.1.9:5080;transport=udp SIP/2.0
- Record-Route: <sip:216.115.69.144;lr>
- Max-Forwards: 67
- Record-Route: <sip:216.115.69.132;lr>
- From: "LINDEN AL" <sip:+13342120202@fl.gg>;tag=gK0c300052
- To: <sip:+13342120101@fl.gg>;tag=11XgN86N3ZD7D
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bKde3d.1f2733b236be9217010961c30b610d34.0
- Via: SIP/2.0/UDP 216.115.69.132;branch=z9hG4bKde3d.f4a0957d6b43b5b1b5630f5a5aae81ca.0
- Via: SIP/2.0/UDP 74.120.93.200:5060;branch=z9hG4bK0cB2b64939e78101b1f
- Call-ID: 522992438_133801219@74.120.93.200
- CSeq: 85750 ACK
- Content-Length: 0
- ------------------------------------------------------------------------
- 2017-05-11 15:15:24.332589 [DEBUG] sofia.c:7247 Channel sofia/external/+13342120202@fl.gg entering state [ready][200]
- 2017-05-11 15:15:24.831641 [DEBUG] switch_rtp.c:7245 Correct audio ip/port confirmed.
- recv 676 bytes from udp/[216.115.69.144]:5060 at 15:15:23.788997:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- From: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- To: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- Via: SIP/2.0/UDP 192.168.1.9:5080;received=68.157.150.128;rport=5080;branch=z9hG4bKgappyH30KtX9S
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 106928994 INVITE
- Content-Type: application/sdp
- Contact: <sip:64.194.139.60:5060;transport=udp>
- Content-Length: 166
- Record-Route: <sip:216.115.69.133;lr>
- Record-Route: <sip:216.115.69.144;lr>
- Supported: timer
- v=0
- o=- 188 1 IN IP4 64.194.139.60
- s=-
- c=IN IP4 64.194.139.60
- t=0 0
- m=audio 31434 RTP/AVP 0 101
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-15
- a=ptime:20
- ------------------------------------------------------------------------
- 2017-05-11 15:15:25.108665 [DEBUG] sofia.c:7247 Channel sofia/external/13342120101 entering state [completing][200]
- 2017-05-11 15:15:25.108665 [DEBUG] sofia.c:7257 Remote SDP:
- v=0
- o=- 188 1 IN IP4 64.194.139.60
- s=-
- c=IN IP4 64.194.139.60
- t=0 0
- m=audio 31434 RTP/AVP 0 101
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-15
- a=ptime:20
- send 764 bytes to udp/[216.115.69.144]:5060 at 15:15:23.790283:
- ------------------------------------------------------------------------
- ACK sip:64.194.139.60:5060;transport=udp SIP/2.0
- Via: SIP/2.0/UDP 192.168.1.9:5080;rport;branch=z9hG4bKHKFF0cm4g3KvN
- Route: <sip:216.115.69.144;lr>
- Route: <sip:216.115.69.133;lr>
- Max-Forwards: 70
- From: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- To: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 106928994 ACK
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- Proxy-Authorization: Digest username="28308479", realm="sip.flowroute.com", nonce="WRS5b1kUuEN/adTD6CuWvpqXwB8IjeFy", cnonce="AVpTnbEhEjWe0wgAJ3evvg", algorithm=MD5, uri="sip:13342120101@sip.flowroute.com", response="6684a94d055d89e1cca692ab87e86933", qop=auth, nc=00000001
- Content-Length: 0
- ------------------------------------------------------------------------
- 2017-05-11 15:15:25.108665 [DEBUG] sofia.c:7247 Channel sofia/external/13342120101 entering state [ready][200]
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:5169 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:5030 Set telephone-event payload to 101@8000
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:3425 Set Codec sofia/external/13342120101 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_codec.c:111 sofia/external/13342120101 Original read codec set to PCMU:0
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:5373 Set telephone-event payload to 101@8000
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:5431 sofia/external/13342120101 Set 2833 dtmf send payload to 101 recv payload to 101
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:8148 AUDIO RTP [sofia/external/13342120101] 192.168.1.9 port 28132 -> 64.194.139.60 port 31434 codec: 0 ms: 20
- 2017-05-11 15:15:25.108665 [DEBUG] switch_rtp.c:4096 Starting timer [soft] 160 bytes per 20ms
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:8451 sofia/external/13342120101 Set 2833 dtmf send payload to 101
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:8458 sofia/external/13342120101 Set 2833 dtmf receive payload to 101
- 2017-05-11 15:15:25.108665 [DEBUG] switch_core_media.c:8481 sofia/external/13342120101 Set rtp dtmf delay to 40
- 2017-05-11 15:15:25.108665 [NOTICE] sofia.c:8383 Channel [sofia/external/13342120101] has been answered
- 2017-05-11 15:15:25.108665 [DEBUG] switch_channel.c:3780 (sofia/external/13342120101) Callstate Change DOWN -> ACTIVE
- 2017-05-11 15:15:25.129136 [DEBUG] switch_ivr_originate.c:3695 Originate Resulted in Success: [sofia/external/13342120101]
- 2017-05-11 15:15:25.129136 [INFO] switch_channel.c:3130 sofia/external/13342120101 Flipping CID from "" <13342120202> to "Outbound Call" <13342120101>
- 2017-05-11 15:15:25.129136 [DEBUG] mod_commands.c:4865 (sofia/external/13342120101) State Change CS_CONSUME_MEDIA -> CS_EXECUTE
- 2017-05-11 15:15:25.129136 [DEBUG] switch_core_state_machine.c:584 (sofia/external/13342120101) Running State Change CS_EXECUTE (Cur 2 Tot 126)
- 2017-05-11 15:15:25.129136 [DEBUG] switch_core_state_machine.c:650 (sofia/external/13342120101) State EXECUTE
- 2017-05-11 15:15:25.129136 [DEBUG] mod_sofia.c:209 sofia/external/13342120101 SOFIA EXECUTE
- 2017-05-11 15:15:25.129136 [DEBUG] switch_core_state_machine.c:328 sofia/external/13342120101 Standard EXECUTE
- EXECUTE sofia/external/13342120101 txfax(/tmp/txfax-sample.tiff)
- 2017-05-11 15:15:25.129136 [DEBUG] mod_spandsp_fax.c:1459 Raw read codec activation Success L16 20000
- 2017-05-11 15:15:25.129136 [DEBUG] switch_core_codec.c:223 sofia/external/13342120101 Push codec L16:100
- 2017-05-11 15:15:25.129136 [DEBUG] mod_spandsp_fax.c:1477 Raw write codec activation Success L16
- recv 676 bytes from udp/[216.115.69.144]:5060 at 15:15:24.107603:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- From: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- To: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- Via: SIP/2.0/UDP 192.168.1.9:5080;received=68.157.150.128;rport=5080;branch=z9hG4bKgappyH30KtX9S
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 106928994 INVITE
- Content-Type: application/sdp
- Contact: <sip:64.194.139.60:5060;transport=udp>
- Content-Length: 166
- Record-Route: <sip:216.115.69.133;lr>
- Record-Route: <sip:216.115.69.144;lr>
- Supported: timer
- v=0
- o=- 188 1 IN IP4 64.194.139.60
- s=-
- c=IN IP4 64.194.139.60
- t=0 0
- m=audio 31434 RTP/AVP 0 101
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-15
- a=ptime:20
- ------------------------------------------------------------------------
- send 764 bytes to udp/[216.115.69.144]:5060 at 15:15:24.107719:
- ------------------------------------------------------------------------
- ACK sip:64.194.139.60:5060;transport=udp SIP/2.0
- Via: SIP/2.0/UDP 192.168.1.9:5080;rport;branch=z9hG4bKHKFF0cm4g3KvN
- Route: <sip:216.115.69.144;lr>
- Route: <sip:216.115.69.133;lr>
- Max-Forwards: 70
- From: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- To: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 106928994 ACK
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- Proxy-Authorization: Digest username="28308479", realm="sip.flowroute.com", nonce="WRS5b1kUuEN/adTD6CuWvpqXwB8IjeFy", cnonce="AVpTnbEhEjWe0wgAJ3evvg", algorithm=MD5, uri="sip:13342120101@sip.flowroute.com", response="6684a94d055d89e1cca692ab87e86933", qop=auth, nc=00000001
- Content-Length: 0
- ------------------------------------------------------------------------
- 2017-05-11 15:15:25.572268 [DEBUG] switch_rtp.c:7245 Correct audio ip/port confirmed.
- 2017-05-11 15:15:26.009173 [DEBUG] switch_ivr_play_say.c:1942 done playing file silence_stream://2000
- EXECUTE sofia/external/+13342120202@fl.gg rxfax(/tmp/rxfax.tif)
- 2017-05-11 15:15:26.009173 [DEBUG] mod_spandsp_fax.c:1459 Raw read codec activation Success L16 20000
- 2017-05-11 15:15:26.009173 [DEBUG] switch_core_codec.c:223 sofia/external/+13342120202@fl.gg Push codec L16:100
- 2017-05-11 15:15:26.009173 [DEBUG] mod_spandsp_fax.c:1477 Raw write codec activation Success L16
- recv 953 bytes from udp/[216.115.69.144]:5060 at 15:15:28.921900:
- ------------------------------------------------------------------------
- INVITE sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute SIP/2.0
- Record-Route: <sip:216.115.69.144;lr>
- Record-Route: <sip:216.115.69.133;lr>
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK7d7c.f7fa80f1cd9cf2de99fe619c161a72b6.0
- Via: SIP/2.0/UDP 216.115.69.133;branch=z9hG4bK7d7c.be28f3b035f1db2386928d127fed92f6.0
- Via: SIP/2.0/UDP 64.194.139.60:5060;branch=z9hG4bKvuf6ja4vqae7era50vf8vir143-g0ka
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- Content-Type: application/sdp
- CSeq: 1 INVITE
- Contact: <sip:64.194.139.60:5060;transport=udp>
- Max-Forwards: 67
- Content-Length: 213
- Supported: timer
- v=0
- o=- 188 2 IN IP4 64.194.139.60
- s=-
- c=IN IP4 64.194.139.60
- t=0 0
- m=audio 31434 RTP/AVP 0 18 101
- a=rtpmap:18 G729/8000
- a=fmtp:18 annexb=no
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-15
- a=ptime:20
- ------------------------------------------------------------------------
- 2017-05-11 15:15:30.248832 [DEBUG] sofia.c:7247 Channel sofia/external/13342120101 entering state [received][100]
- 2017-05-11 15:15:30.248832 [DEBUG] sofia.c:7257 Remote SDP:
- v=0
- o=- 188 2 IN IP4 64.194.139.60
- s=-
- c=IN IP4 64.194.139.60
- t=0 0
- m=audio 31434 RTP/AVP 0 18 101
- a=rtpmap:18 G729/8000
- a=fmtp:18 annexb=no
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-15
- a=ptime:20
- send 395 bytes to udp/[216.115.69.144]:5060 at 15:15:28.932181:
- ------------------------------------------------------------------------
- SIP/2.0 100 Trying
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK7d7c.f7fa80f1cd9cf2de99fe619c161a72b6.0
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 1 INVITE
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Content-Length: 0
- ------------------------------------------------------------------------
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5169 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5030 Set telephone-event payload to 101@8000
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5373 Set telephone-event payload to 101@8000
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:5431 sofia/external/13342120101 Set 2833 dtmf send payload to 101 recv payload to 101
- 2017-05-11 15:15:30.248832 [DEBUG] switch_core_media.c:8131 Audio params are unchanged for sofia/external/13342120101.
- 2017-05-11 15:15:30.248832 [DEBUG] sofia.c:8162 Processing updated SDP
- send 1164 bytes to udp/[216.115.69.144]:5060 at 15:15:28.933432:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK7d7c.f7fa80f1cd9cf2de99fe619c161a72b6.0
- Via: SIP/2.0/UDP 216.115.69.133;branch=z9hG4bK7d7c.be28f3b035f1db2386928d127fed92f6.0
- Via: SIP/2.0/UDP 64.194.139.60:5060;branch=z9hG4bKvuf6ja4vqae7era50vf8vir143-g0ka
- Record-Route: <sip:216.115.69.144;lr>
- Record-Route: <sip:216.115.69.133;lr>
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 1 INVITE
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 240
- v=0
- o=FreeSWITCH 1494501984 1494501986 IN IP4 192.168.1.9
- s=FreeSWITCH
- c=IN IP4 192.168.1.9
- t=0 0
- m=audio 28132 RTP/AVP 0 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- m=video 0 RTP/AVP 19
- ------------------------------------------------------------------------
- 2017-05-11 15:15:30.268849 [DEBUG] sofia.c:7247 Channel sofia/external/13342120101 entering state [completed][200]
- send 1164 bytes to udp/[216.115.69.144]:5060 at 15:15:29.435870:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK7d7c.f7fa80f1cd9cf2de99fe619c161a72b6.0
- Via: SIP/2.0/UDP 216.115.69.133;branch=z9hG4bK7d7c.be28f3b035f1db2386928d127fed92f6.0
- Via: SIP/2.0/UDP 64.194.139.60:5060;branch=z9hG4bKvuf6ja4vqae7era50vf8vir143-g0ka
- Record-Route: <sip:216.115.69.144;lr>
- Record-Route: <sip:216.115.69.133;lr>
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 1 INVITE
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 240
- v=0
- o=FreeSWITCH 1494501984 1494501986 IN IP4 192.168.1.9
- s=FreeSWITCH
- c=IN IP4 192.168.1.9
- t=0 0
- m=audio 28132 RTP/AVP 0 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- m=video 0 RTP/AVP 19
- ------------------------------------------------------------------------
- recv 636 bytes from udp/[216.115.69.144]:5060 at 15:15:29.724580:
- ------------------------------------------------------------------------
- ACK sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute SIP/2.0
- Record-Route: <sip:216.115.69.144;lr>
- Record-Route: <sip:216.115.69.133;lr>
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK7d7c.a62f727a0796cc5dc430bb77d434bc2d.0
- Via: SIP/2.0/UDP 216.115.69.133;branch=z9hG4bK7d7c.46aa921efde510d4faceef72629450d4.0
- Via: SIP/2.0/UDP 64.194.139.60:5060;branch=z9hG4bKvuf6ja4vqae7era50vf8vir143-g0oa.1
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 1 ACK
- Max-Forwards: 67
- Content-Length: 0
- ------------------------------------------------------------------------
- 2017-05-11 15:15:31.048955 [DEBUG] sofia.c:7247 Channel sofia/external/13342120101 entering state [ready][200]
- recv 952 bytes from udp/[216.115.69.144]:5060 at 15:15:29.961946:
- ------------------------------------------------------------------------
- INVITE sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute SIP/2.0
- Record-Route: <sip:216.115.69.144;lr>
- Record-Route: <sip:216.115.69.133;lr>
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK4d7c.47bddee33a2277ce16a1efeba0c3cffe.0
- Via: SIP/2.0/UDP 216.115.69.133;branch=z9hG4bK4d7c.2be7bbcc85afe9c142a3586dd5143ba2.0
- Via: SIP/2.0/UDP 64.194.139.60:5060;branch=z9hG4bKvuf6ja4vqae7era50vf8vir143-1ka
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- Content-Type: application/sdp
- CSeq: 2 INVITE
- Contact: <sip:64.194.139.60:5060;transport=udp>
- Max-Forwards: 67
- Content-Length: 213
- Supported: timer
- v=0
- o=- 188 3 IN IP4 64.194.139.60
- s=-
- c=IN IP4 64.194.139.60
- t=0 0
- m=audio 31434 RTP/AVP 0 18 101
- a=rtpmap:18 G729/8000
- a=fmtp:18 annexb=no
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-15
- a=ptime:20
- ------------------------------------------------------------------------
- send 395 bytes to udp/[216.115.69.144]:5060 at 15:15:29.972568:
- ------------------------------------------------------------------------
- SIP/2.0 100 Trying
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK4d7c.47bddee33a2277ce16a1efeba0c3cffe.0
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 2 INVITE
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Content-Length: 0
- ------------------------------------------------------------------------
- 2017-05-11 15:15:31.290516 [DEBUG] sofia.c:7247 Channel sofia/external/13342120101 entering state [received][100]
- 2017-05-11 15:15:31.290516 [DEBUG] sofia.c:7257 Remote SDP:
- v=0
- o=- 188 3 IN IP4 64.194.139.60
- s=-
- c=IN IP4 64.194.139.60
- t=0 0
- m=audio 31434 RTP/AVP 0 18 101
- a=rtpmap:18 G729/8000
- a=fmtp:18 annexb=no
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-15
- a=ptime:20
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5169 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5114 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5030 Set telephone-event payload to 101@8000
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5373 Set telephone-event payload to 101@8000
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:5431 sofia/external/13342120101 Set 2833 dtmf send payload to 101 recv payload to 101
- 2017-05-11 15:15:31.290516 [DEBUG] switch_core_media.c:8131 Audio params are unchanged for sofia/external/13342120101.
- 2017-05-11 15:15:31.290516 [DEBUG] sofia.c:8162 Processing updated SDP
- send 1163 bytes to udp/[216.115.69.144]:5060 at 15:15:29.973883:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK4d7c.47bddee33a2277ce16a1efeba0c3cffe.0
- Via: SIP/2.0/UDP 216.115.69.133;branch=z9hG4bK4d7c.2be7bbcc85afe9c142a3586dd5143ba2.0
- Via: SIP/2.0/UDP 64.194.139.60:5060;branch=z9hG4bKvuf6ja4vqae7era50vf8vir143-1ka
- Record-Route: <sip:216.115.69.144;lr>
- Record-Route: <sip:216.115.69.133;lr>
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 2 INVITE
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 240
- v=0
- o=FreeSWITCH 1494501984 1494501986 IN IP4 192.168.1.9
- s=FreeSWITCH
- c=IN IP4 192.168.1.9
- t=0 0
- m=audio 28132 RTP/AVP 0 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- m=video 0 RTP/AVP 19
- ------------------------------------------------------------------------
- 2017-05-11 15:15:31.308966 [DEBUG] sofia.c:7247 Channel sofia/external/13342120101 entering state [completed][200]
- send 1163 bytes to udp/[216.115.69.144]:5060 at 15:15:30.475014:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK4d7c.47bddee33a2277ce16a1efeba0c3cffe.0
- Via: SIP/2.0/UDP 216.115.69.133;branch=z9hG4bK4d7c.2be7bbcc85afe9c142a3586dd5143ba2.0
- Via: SIP/2.0/UDP 64.194.139.60:5060;branch=z9hG4bKvuf6ja4vqae7era50vf8vir143-1ka
- Record-Route: <sip:216.115.69.144;lr>
- Record-Route: <sip:216.115.69.133;lr>
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 2 INVITE
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 240
- v=0
- o=FreeSWITCH 1494501984 1494501986 IN IP4 192.168.1.9
- s=FreeSWITCH
- c=IN IP4 192.168.1.9
- t=0 0
- m=audio 28132 RTP/AVP 0 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- m=video 0 RTP/AVP 19
- ------------------------------------------------------------------------
- recv 635 bytes from udp/[216.115.69.144]:5060 at 15:15:30.739333:
- ------------------------------------------------------------------------
- ACK sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute SIP/2.0
- Record-Route: <sip:216.115.69.144;lr>
- Record-Route: <sip:216.115.69.133;lr>
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK4d7c.d189142d598e03dcb5cb81d0f97f128b.0
- Via: SIP/2.0/UDP 216.115.69.133;branch=z9hG4bK4d7c.d9bacb52a7a5c864826e47bd88f50149.0
- Via: SIP/2.0/UDP 64.194.139.60:5060;branch=z9hG4bKvuf6ja4vqae7era50vf8vir143-1oa.1
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 2 ACK
- Max-Forwards: 67
- Content-Length: 0
- ------------------------------------------------------------------------
- 2017-05-11 15:15:32.070550 [DEBUG] sofia.c:7247 Channel sofia/external/13342120101 entering state [ready][200]
- recv 495 bytes from udp/[216.115.69.144]:5060 at 15:16:00.252434:
- ------------------------------------------------------------------------
- OPTIONS sip:68.157.150.128:5080;transport=udp SIP/2.0
- Max-Forwards: 10
- Record-Route: <sip:216.115.69.144;lr>
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK97e1.f645f0f31e7ce35a5fad5fe97e29beb3.0
- Via: SIP/2.0/UDP 70.167.153.136:5060;branch=0
- Route: <sip:216.115.69.144;lr;received='sip:68.157.150.128:5080;transport=udp'>
- From: sip:ping@invalid;tag=dfa02e29
- To: sip:68.157.150.128:5080;transport=udp
- Call-ID: 031b3b74-b2524d32-dbb0b6@70.167.153.136
- CSeq: 1 OPTIONS
- Content-Length: 0
- ------------------------------------------------------------------------
- send 722 bytes to udp/[216.115.69.144]:5060 at 15:16:00.252929:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK97e1.f645f0f31e7ce35a5fad5fe97e29beb3.0
- Via: SIP/2.0/UDP 70.167.153.136:5060;branch=0
- Record-Route: <sip:216.115.69.144;lr>
- From: sip:ping@invalid;tag=dfa02e29
- To: <sip:68.157.150.128:5080>;transport=udp;tag=2aQ9p3QS083SS
- Call-ID: 031b3b74-b2524d32-dbb0b6@70.167.153.136
- CSeq: 1 OPTIONS
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:496 ==============================================================================
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:508 Fax processing not successful - result (3) Timed out waiting for the first message.
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:513 Remote station id:
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:514 Local station id: SpanDSP Fax Ident
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:515 Pages transferred: 0
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:517 Total fax pages: 0
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:518 Image resolution: 0x0
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:519 Transfer Rate: 14400
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:521 ECM status off
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:522 remote country:
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:523 remote vendor:
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:524 remote model:
- 2017-05-11 15:16:05.332888 [DEBUG] mod_spandsp_fax.c:526 ==============================================================================
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_codec.c:248 sofia/external/+13342120202@fl.gg Restore previous codec PCMU:0.
- EXECUTE sofia/external/+13342120202@fl.gg hangup()
- 2017-05-11 15:16:05.348781 [NOTICE] mod_dptools.c:1326 Hangup sofia/external/+13342120202@fl.gg [CS_EXECUTE] [NORMAL_CLEARING]
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_session.c:2884 sofia/external/+13342120202@fl.gg skip receive message [PHONE_EVENT] (channel is hungup already)
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:650 (sofia/external/+13342120202@fl.gg) State EXECUTE going to sleep
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+13342120202@fl.gg) Running State Change CS_HANGUP (Cur 2 Tot 126)
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:850 (sofia/external/+13342120202@fl.gg) Callstate Change ACTIVE -> HANGUP
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:852 (sofia/external/+13342120202@fl.gg) State HANGUP
- 2017-05-11 15:16:05.348781 [DEBUG] mod_sofia.c:449 Channel sofia/external/+13342120202@fl.gg hanging up, cause: NORMAL_CLEARING
- 2017-05-11 15:16:05.348781 [DEBUG] mod_sofia.c:502 Sending BYE to sofia/external/+13342120202@fl.gg
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:60 sofia/external/+13342120202@fl.gg Standard HANGUP, cause: NORMAL_CLEARING
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:852 (sofia/external/+13342120202@fl.gg) State HANGUP going to sleep
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:619 (sofia/external/+13342120202@fl.gg) State Change CS_HANGUP -> CS_REPORTING
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+13342120202@fl.gg) Running State Change CS_REPORTING (Cur 2 Tot 126)
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:938 (sofia/external/+13342120202@fl.gg) State REPORTING
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:174 sofia/external/+13342120202@fl.gg Standard REPORTING, cause: NORMAL_CLEARING
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:938 (sofia/external/+13342120202@fl.gg) State REPORTING going to sleep
- send 648 bytes to udp/[216.115.69.144]:5060 at 15:16:04.022757:
- ------------------------------------------------------------------------
- BYE sip:+13342120202@74.120.93.200:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.1.9:5080;rport;branch=z9hG4bKjv871747DcaFH
- Route: <sip:216.115.69.144;lr>
- Route: <sip:216.115.69.132;lr>
- Max-Forwards: 70
- From: <sip:+13342120101@fl.gg>;tag=11XgN86N3ZD7D
- To: "LINDEN AL" <sip:+13342120202@fl.gg>;tag=gK0c300052
- Call-ID: 522992438_133801219@74.120.93.200
- CSeq: 106929018 BYE
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Reason: Q.850;cause=16;text="NORMAL_CLEARING"
- Content-Length: 0
- ------------------------------------------------------------------------
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:610 (sofia/external/+13342120202@fl.gg) State Change CS_REPORTING -> CS_DESTROY
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_session.c:1712 Session 126 (sofia/external/+13342120202@fl.gg) Locked, Waiting on external entities
- 2017-05-11 15:16:05.348781 [NOTICE] switch_core_session.c:1730 Session 126 (sofia/external/+13342120202@fl.gg) Ended
- 2017-05-11 15:16:05.348781 [NOTICE] switch_core_session.c:1734 Close Channel sofia/external/+13342120202@fl.gg [CS_DESTROY]
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:741 (sofia/external/+13342120202@fl.gg) Running State Change CS_DESTROY (Cur 1 Tot 126)
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:751 (sofia/external/+13342120202@fl.gg) State DESTROY
- 2017-05-11 15:16:05.348781 [DEBUG] mod_sofia.c:354 sofia/external/+13342120202@fl.gg SOFIA DESTROY
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:181 sofia/external/+13342120202@fl.gg Standard DESTROY
- 2017-05-11 15:16:05.348781 [DEBUG] switch_core_state_machine.c:751 (sofia/external/+13342120202@fl.gg) State DESTROY going to sleep
- recv 403 bytes from udp/[216.115.69.144]:5060 at 15:16:04.202932:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- From: <sip:+13342120101@fl.gg>;tag=11XgN86N3ZD7D
- To: "LINDEN AL" <sip:+13342120202@fl.gg>;tag=gK0c300052
- Via: SIP/2.0/UDP 192.168.1.9:5080;received=68.157.150.128;rport=5080;branch=z9hG4bKjv871747DcaFH
- Call-ID: 522992438_133801219@74.120.93.200
- CSeq: 106929018 BYE
- Record-Route: <sip:216.115.69.132:5060;lr>
- Record-Route: <sip:216.115.69.144:5060;lr>
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 652 bytes from udp/[216.115.69.144]:5060 at 15:16:04.853765:
- ------------------------------------------------------------------------
- BYE sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute SIP/2.0
- Record-Route: <sip:216.115.69.144;lr>
- Record-Route: <sip:216.115.69.133;lr>
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK5d7c.89d5cf83b641f01f91b4c109dd31d9e1.0
- Via: SIP/2.0/UDP 216.115.69.133;branch=z9hG4bK5d7c.a5ef42e1eedcbde16bc8bd65c6b85cbf.0
- Via: SIP/2.0/UDP 64.194.139.60:5060;branch=z9hG4bKvuf6ja4vqae7era50vf8vir143-g1sa
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 3 BYE
- Max-Forwards: 67
- Content-Length: 0
- Supported: timer
- ------------------------------------------------------------------------
- 2017-05-11 15:16:06.169434 [NOTICE] sofia.c:1079 Hangup sofia/external/13342120101 [CS_EXECUTE] [NORMAL_CLEARING]
- 2017-05-11 15:16:06.169434 [DEBUG] mod_spandsp_fax.c:496 ==============================================================================
- 2017-05-11 15:16:06.169434 [DEBUG] mod_spandsp_fax.c:508 Fax processing not successful - result (49) The call dropped prematurely.
- 2017-05-11 15:16:06.169434 [DEBUG] mod_spandsp_fax.c:513 Remote station id:
- 2017-05-11 15:16:06.169434 [DEBUG] mod_spandsp_fax.c:514 Local station id: SpanDSP Fax Ident
- 2017-05-11 15:16:06.169434 [DEBUG] mod_spandsp_fax.c:515 Pages transferred: 0
- 2017-05-11 15:16:06.169434 [DEBUG] mod_spandsp_fax.c:517 Total fax pages: 0
- 2017-05-11 15:16:06.169434 [DEBUG] mod_spandsp_fax.c:518 Image resolution: 0x0
- 2017-05-11 15:16:06.169434 [DEBUG] mod_spandsp_fax.c:519 Transfer Rate: 14400
- 2017-05-11 15:16:06.169434 [DEBUG] mod_spandsp_fax.c:521 ECM status off
- 2017-05-11 15:16:06.169434 [DEBUG] mod_spandsp_fax.c:522 remote country:
- 2017-05-11 15:16:06.189077 [DEBUG] mod_spandsp_fax.c:523 remote vendor:
- 2017-05-11 15:16:06.189077 [DEBUG] mod_spandsp_fax.c:524 remote model:
- send 682 bytes to udp/[216.115.69.144]:5060 at 15:16:04.856262:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK5d7c.89d5cf83b641f01f91b4c109dd31d9e1.0
- 2017-05-11 15:16:06.189077 [DEBUG] mod_spandsp_fax.c:526 ==============================================================================
- Via: SIP/2.0/UDP 216.115.69.133;branch=z9hG4bK5d7c.a5ef42e1eedcbde16bc8bd65c6b85cbf.0
- Via: SIP/2.0/UDP 64.194.139.60:5060;branch=z9hG4bKvuf6ja4vqae7era50vf8vir143-g1sa
- From: <sip:13342120101@sip.flowroute.com>;tag=9311370351365563085
- To: "" <sip:28308479@sip.flowroute.com>;tag=ZFBZHj5e9D11p
- Call-ID: 013d52c8-b121-1235-d39e-08002777afbe
- CSeq: 3 BYE
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Content-Length: 0
- ------------------------------------------------------------------------
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_codec.c:248 sofia/external/13342120101 Restore previous codec PCMU:0.
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_session.c:2884 sofia/external/13342120101 skip receive message [PHONE_EVENT] (channel is hungup already)
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:650 (sofia/external/13342120101) State EXECUTE going to sleep
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:584 (sofia/external/13342120101) Running State Change CS_HANGUP (Cur 1 Tot 126)
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:850 (sofia/external/13342120101) Callstate Change ACTIVE -> HANGUP
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:852 (sofia/external/13342120101) State HANGUP
- 2017-05-11 15:16:06.189077 [DEBUG] mod_sofia.c:449 Channel sofia/external/13342120101 hanging up, cause: NORMAL_CLEARING
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:60 sofia/external/13342120101 Standard HANGUP, cause: NORMAL_CLEARING
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:852 (sofia/external/13342120101) State HANGUP going to sleep
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:619 (sofia/external/13342120101) State Change CS_HANGUP -> CS_REPORTING
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:584 (sofia/external/13342120101) Running State Change CS_REPORTING (Cur 1 Tot 126)
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:938 (sofia/external/13342120101) State REPORTING
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:174 sofia/external/13342120101 Standard REPORTING, cause: NORMAL_CLEARING
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:938 (sofia/external/13342120101) State REPORTING going to sleep
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:610 (sofia/external/13342120101) State Change CS_REPORTING -> CS_DESTROY
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_session.c:1712 Session 125 (sofia/external/13342120101) Locked, Waiting on external entities
- 2017-05-11 15:16:06.189077 [NOTICE] switch_core_session.c:1730 Session 125 (sofia/external/13342120101) Ended
- 2017-05-11 15:16:06.189077 [NOTICE] switch_core_session.c:1734 Close Channel sofia/external/13342120101 [CS_DESTROY]
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:741 (sofia/external/13342120101) Running State Change CS_DESTROY (Cur 0 Tot 126)
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:751 (sofia/external/13342120101) State DESTROY
- 2017-05-11 15:16:06.189077 [DEBUG] mod_sofia.c:354 sofia/external/13342120101 SOFIA DESTROY
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:181 sofia/external/13342120101 Standard DESTROY
- 2017-05-11 15:16:06.189077 [DEBUG] switch_core_state_machine.c:751 (sofia/external/13342120101) State DESTROY going to sleep
- freeswitch@freeswitch-test> show calls
- 0 total.
- recv 757 bytes from udp/[192.168.1.26]:5060 at 15:16:47.032094:
- ------------------------------------------------------------------------
- REGISTER sip:192.168.1.9 SIP/2.0
- Via: SIP/2.0/UDP 192.168.1.26:5060;branch=z9hG4bK72c07dbdf3b3fa9f
- From: <sip:1009@192.168.1.9;user=phone>;tag=773c4c169c139c19
- To: <sip:1009@192.168.1.9;user=phone>
- Contact: <sip:1009@192.168.1.26:5060;transport=udp;user=phone>
- Supported: path
- Authorization: Digest username="1009", realm="192.168.1.9", algorithm=MD5, uri="sip:192.168.1.9", qop=auth, nc=00000003, cnonce="6bb850224bf56cc1", nonce="17e1a876-403f-4250-ba07-9d0ac6aa0fe5", response="317a6fb5b32cea35dd8d825015f60c74"
- Call-ID: 7b8e2647b544354a@192.168.1.26
- CSeq: 10062 REGISTER
- Expires: 3600
- User-Agent: Grandstream BT200 1.1.6.32
- Max-Forwards: 70
- Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK
- Content-Length: 0
- ------------------------------------------------------------------------
- send 621 bytes to udp/[192.168.1.26]:5060 at 15:16:47.034312:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.1.26:5060;branch=z9hG4bK72c07dbdf3b3fa9f
- From: <sip:1009@192.168.1.9;user=phone>;tag=773c4c169c139c19
- To: <sip:1009@192.168.1.9;user=phone>;tag=yN0XB1ge8Qc4N
- Call-ID: 7b8e2647b544354a@192.168.1.26
- CSeq: 10062 REGISTER
- Contact: <sip:1009@192.168.1.26:5060;transport=udp;user=phone>;expires=3600
- Date: Thu, 11 May 2017 19:16:48 GMT
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 495 bytes from udp/[216.115.69.144]:5060 at 15:16:55.391028:
- ------------------------------------------------------------------------
- OPTIONS sip:68.157.150.128:5080;transport=udp SIP/2.0
- Max-Forwards: 10
- Record-Route: <sip:216.115.69.144;lr>
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bKf09a.9ef1429cd5c4d40209eb14b57630178b.0
- Via: SIP/2.0/UDP 70.167.153.136:5060;branch=0
- Route: <sip:216.115.69.144;lr;received='sip:68.157.150.128:5080;transport=udp'>
- From: sip:ping@invalid;tag=ee732e29
- To: sip:68.157.150.128:5080;transport=udp
- Call-ID: 031b3b74-c1254d32-5fb0b6@70.167.153.136
- CSeq: 1 OPTIONS
- Content-Length: 0
- ------------------------------------------------------------------------
- send 722 bytes to udp/[216.115.69.144]:5060 at 15:16:55.391601:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bKf09a.9ef1429cd5c4d40209eb14b57630178b.0
- Via: SIP/2.0/UDP 70.167.153.136:5060;branch=0
- Record-Route: <sip:216.115.69.144;lr>
- From: sip:ping@invalid;tag=ee732e29
- To: <sip:68.157.150.128:5080>;transport=udp;tag=3Kg2ry8vXHtcN
- Call-ID: 031b3b74-c1254d32-5fb0b6@70.167.153.136
- CSeq: 1 OPTIONS
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[62.141.42.201]:5062 at 15:16:57.723319:
- ------------------------------------------------------------------------
- OPTIONS sip:100@68.157.150.128 SIP/2.0
- Via: SIP/2.0/UDP 62.141.42.201:5062;branch=z9hG4bK-2381670077;rport
- Content-Length: 0
- From: "sipvicious"<sip:100@1.1.1.1>; tag=343439643936383031336334013336393435393136
- Accept: application/sdp
- User-Agent: friendly-scanner
- To: "sipvicious"<sip:100@1.1.1.1>
- Contact: sip:100@62.141.42.201:5062
- CSeq: 1 OPTIONS
- Call-ID: 39583324158554579239185
- Max-Forwards: 70
- ------------------------------------------------------------------------
- send 646 bytes to udp/[62.141.42.201]:5062 at 15:16:57.723786:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 62.141.42.201:5062;branch=z9hG4bK-2381670077;rport=5062
- From: "sipvicious"<sip:100@1.1.1.1>; tag=343439643936383031336334013336393435393136
- To: "sipvicious" <sip:100@1.1.1.1>;tag=4v9ttSS0ttgZg
- Call-ID: 39583324158554579239185
- CSeq: 1 OPTIONS
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 496 bytes from udp/[216.115.69.144]:5060 at 15:17:12.220460:
- ------------------------------------------------------------------------
- OPTIONS sip:68.157.150.128:5080;transport=udp SIP/2.0
- Max-Forwards: 10
- Record-Route: <sip:216.115.69.144;lr>
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK03e3.617bca3a5f7fbd8eda9f23ac9181ec05.0
- Via: SIP/2.0/UDP 216.115.69.131:5060;branch=0
- Route: <sip:216.115.69.144;lr;received='sip:68.157.150.128:5080;transport=udp'>
- From: sip:ping@invalid;tag=2c6024e5
- To: sip:68.157.150.128:5080;transport=udp
- Call-ID: 84599eb4-1dc28c47-cd1d9c2@216.115.69.131
- CSeq: 1 OPTIONS
- Content-Length: 0
- ------------------------------------------------------------------------
- send 723 bytes to udp/[216.115.69.144]:5060 at 15:17:12.221207:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 216.115.69.144;branch=z9hG4bK03e3.617bca3a5f7fbd8eda9f23ac9181ec05.0
- Via: SIP/2.0/UDP 216.115.69.131:5060;branch=0
- Record-Route: <sip:216.115.69.144;lr>
- From: sip:ping@invalid;tag=2c6024e5
- To: <sip:68.157.150.128:5080>;transport=udp;tag=552Kvma4Q36Hc
- Call-ID: 84599eb4-1dc28c47-cd1d9c2@216.115.69.131
- CSeq: 1 OPTIONS
- Contact: <sip:gw+flowroute@192.168.1.9:5080;transport=udp;gw=flowroute>
- User-Agent: FreeSWITCH-mod_sofia/1.9.0+git~20170505T161917Z~5d4ac1cd3b~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- freeswitch@freeswitch-test>