[Freeswitch-users] FS with SSL/TLS issues!
Vittorio Guglielmo
vittorio.guglielmo at gmail.com
Thu Feb 28 15:36:36 MSK 2013
Anthony,
sofia global siptrace on
and in attachment are the two siptrace:
1. *101* ( Bria iOS 2.3.4 on Iphone 3GS) *===> 102* (Bria 3 release
3.5.0b on Mac OSX 10.7.5)
2. *102* *===> 101*
Both of them have forced only ulaw (first) and alaw (second), and
without TSL/SRTP they call each other without problems.
The behavior is different in the two above cases:
When I call from 101 to 102 I get a *Originate Resulted in Error Cause:
79 [SERVICE_NOT_IMPLEMENTED]*
due to, I believe a: *SIP/2.0 415 Unsupported Media Type*
When I instead call from 102 to 101 I get a *Originate Failed. Cause:
INCOMPATIBLE_DESTINATION*
with a : *SIP/2.0 488 Not Acceptable Here*
Vic
On 28/02/13 00:23, Anthony Minessale wrote:
> sofia global siptrace on
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20130228/88d44a57/attachment-0001.html
-------------- next part --------------
freeswitch at internal>
recv 1333 bytes from tls/[85.18.36.68]:51187 at 12:27:39.121764:
------------------------------------------------------------------------
INVITE sip:102 at voice.wicube.net SIP/2.0
Via: SIP/2.0/TLS 85.18.36.68:51187;rport;branch=z9hG4bKPjbSUoRnakXwBPZqfm76TRKwoxH-KVdl9a;alias
Max-Forwards: 70
From: "101" <sip:101 at voice.wicube.net>;tag=RQ-SQdhcZuhI5SYNSNKTY9F-9-.unsww
To: <sip:102 at voice.wicube.net>
Contact: <sip:101 at 85.18.36.68:51187;transport=TLS;ob>;+sip.ice
Call-ID: 5xUNyMbEzeDbgO48GR2uPiITtdGkVHm9
CSeq: 31360 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
User-Agent: Bria iOS 2.3.4
Content-Type: application/sdp
Content-Length: 717
v=0
o=- 3571043268 3571043268 IN IP4 172.22.55.178
s=cpc_med
c=IN IP4 172.22.55.178
t=0 0
m=audio 53530 RTP/SAVP 0 8 101
a=sendrecv
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:fqwD6Slr4snIn2sJPbAtfR+sLr/VRQbTOmtdi7JH
a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:FvJ8slt1jidvluNFDVItIgmux+WiqgIFoAp+ItS5
a=ice-ufrag:7bec20f6
a=ice-pwd:4b683609
a=candidate:Hac1637b2 1 UDP 2130706431 172.22.55.178 53530 typ host
a=candidate:H55ad1d9 1 UDP 2130706431 5.90.209.217 53530 typ host
a=candidate:Hac1637b2 2 UDP 2130706430 172.22.55.178 58436 typ host
a=candidate:H55ad1d9 2 UDP 2130706430 5.90.209.217 58436 typ host
------------------------------------------------------------------------
send 388 bytes to tls/[85.18.36.68]:51187 at 12:27:39.122154:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/TLS 85.18.36.68:51187;rport=51187;branch=z9hG4bKPjbSUoRnakXwBPZqfm76TRKwoxH-KVdl9a;alias
From: "101" <sip:101 at voice.wicube.net>;tag=RQ-SQdhcZuhI5SYNSNKTY9F-9-.unsww
To: <sip:102 at voice.wicube.net>
Call-ID: 5xUNyMbEzeDbgO48GR2uPiITtdGkVHm9
CSeq: 31360 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.2.6+git~20130104T154559Z~a4247651ca
Content-Length: 0
------------------------------------------------------------------------
2013-02-28 13:07:04.438143 [NOTICE] switch_channel.c:968 New Channel sofia/internal/101 at voice.wicube.net [3d835816-81a2-11e2-ac9e-ad22efd2ace4]
2013-02-28 13:07:04.438143 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.438143 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.458126 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/101 at voice.wicube.net) Running State Change CS_NEW
2013-02-28 13:07:04.458126 [DEBUG] switch_core_state_machine.c:433 (sofia/internal/101 at voice.wicube.net) State NEW
2013-02-28 13:07:04.478139 [DEBUG] sofia.c:7729 IP 85.18.36.68 Rejected by acl "domains". Falling back to Digest auth.
2013-02-28 13:07:04.478139 [WARNING] sofia_reg.c:1502 SIP auth challenge (INVITE) on sofia profile 'internal' for [102 at voice.wicube.net] from ip 85.18.36.68
send 891 bytes to tls/[85.18.36.68]:51187 at 12:27:39.150958:
------------------------------------------------------------------------
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/TLS 85.18.36.68:51187;rport=51187;branch=z9hG4bKPjbSUoRnakXwBPZqfm76TRKwoxH-KVdl9a;alias
From: "101" <sip:101 at voice.wicube.net>;tag=RQ-SQdhcZuhI5SYNSNKTY9F-9-.unsww
To: <sip:102 at voice.wicube.net>;tag=Dm4763BDQjZ6S
Call-ID: 5xUNyMbEzeDbgO48GR2uPiITtdGkVHm9
CSeq: 31360 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.2.6+git~20130104T154559Z~a4247651ca
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Proxy-Authenticate: Digest realm="voice.wicube.net", nonce="3d86ab38-81a2-11e2-ac9f-ad22efd2ace4", algorithm=MD5, qop="auth"
Content-Length: 0
------------------------------------------------------------------------
2013-02-28 13:07:04.478139 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.478139 [DEBUG] sofia.c:1750 detaching session 3d835816-81a2-11e2-ac9e-ad22efd2ace4
recv 362 bytes from tls/[85.18.36.68]:51187 at 12:27:39.207888:
------------------------------------------------------------------------
ACK sip:102 at voice.wicube.net SIP/2.0
Via: SIP/2.0/TLS 85.18.36.68:51187;rport;branch=z9hG4bKPjbSUoRnakXwBPZqfm76TRKwoxH-KVdl9a;alias
Max-Forwards: 70
From: "101" <sip:101 at voice.wicube.net>;tag=RQ-SQdhcZuhI5SYNSNKTY9F-9-.unsww
To: <sip:102 at voice.wicube.net>;tag=Dm4763BDQjZ6S
Call-ID: 5xUNyMbEzeDbgO48GR2uPiITtdGkVHm9
CSeq: 31360 ACK
Content-Length: 0
------------------------------------------------------------------------
recv 1607 bytes from tls/[85.18.36.68]:51187 at 12:27:39.281632:
------------------------------------------------------------------------
INVITE sip:102 at voice.wicube.net SIP/2.0
Via: SIP/2.0/TLS 85.18.36.68:51187;rport;branch=z9hG4bKPjVkpmhYfPXXJ.MmmYQ62ufvtZD0K5i8Lf;alias
Max-Forwards: 70
From: "101" <sip:101 at voice.wicube.net>;tag=RQ-SQdhcZuhI5SYNSNKTY9F-9-.unsww
To: <sip:102 at voice.wicube.net>
Contact: <sip:101 at 85.18.36.68:51187;transport=TLS;ob>;+sip.ice
Call-ID: 5xUNyMbEzeDbgO48GR2uPiITtdGkVHm9
CSeq: 31361 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
User-Agent: Bria iOS 2.3.4
Proxy-Authorization: Digest username="101", realm="voice.wicube.net", nonce="3d86ab38-81a2-11e2-ac9f-ad22efd2ace4", uri="sip:102 at voice.wicube.net", response="6b0c7609274244fe82cf620ca92f32c4", algorithm=MD5, cnonce="GEwL.oSmgLolHXaIddxqHalqr5vm.JPF", qop=auth, nc=00000001
Content-Type: application/sdp
Content-Length: 717
v=0
o=- 3571043268 3571043268 IN IP4 172.22.55.178
s=cpc_med
c=IN IP4 172.22.55.178
t=0 0
m=audio 53530 RTP/SAVP 0 8 101
a=sendrecv
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:fqwD6Slr4snIn2sJPbAtfR+sLr/VRQbTOmtdi7JH
a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:FvJ8slt1jidvluNFDVItIgmux+WiqgIFoAp+ItS5
a=ice-ufrag:7bec20f6
a=ice-pwd:4b683609
a=candidate:Hac1637b2 1 UDP 2130706431 172.22.55.178 53530 typ host
a=candidate:H55ad1d9 1 UDP 2130706431 5.90.209.217 53530 typ host
a=candidate:Hac1637b2 2 UDP 2130706430 172.22.55.178 58436 typ host
a=candidate:H55ad1d9 2 UDP 2130706430 5.90.209.217 58436 typ host
------------------------------------------------------------------------
send 388 bytes to tls/[85.18.36.68]:51187 at 12:27:39.282486:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/TLS 85.18.36.68:51187;rport=51187;branch=z9hG4bKPjVkpmhYfPXXJ.MmmYQ62ufvtZD0K5i8Lf;alias
From: "101" <sip:101 at voice.wicube.net>;tag=RQ-SQdhcZuhI5SYNSNKTY9F-9-.unsww
To: <sip:102 at voice.wicube.net>
Call-ID: 5xUNyMbEzeDbgO48GR2uPiITtdGkVHm9
CSeq: 31361 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.2.6+git~20130104T154559Z~a4247651ca
Content-Length: 0
------------------------------------------------------------------------
2013-02-28 13:07:04.598195 [DEBUG] sofia.c:1842 Re-attaching to session 3d835816-81a2-11e2-ac9e-ad22efd2ace4
2013-02-28 13:07:04.598195 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.598195 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.618122 [DEBUG] sofia.c:7729 IP 85.18.36.68 Rejected by acl "domains". Falling back to Digest auth.
2013-02-28 13:07:04.618122 [DEBUG] sofia.c:5599 Channel sofia/internal/101 at voice.wicube.net entering state [received][100]
2013-02-28 13:07:04.618122 [DEBUG] sofia.c:5610 Remote SDP:
v=0
o=- 3571043268 3571043268 IN IP4 172.22.55.178
s=cpc_med
c=IN IP4 172.22.55.178
t=0 0
m=audio 53530 RTP/SAVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:fqwD6Slr4snIn2sJPbAtfR+sLr/VRQbTOmtdi7JH
a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:FvJ8slt1jidvluNFDVItIgmux+WiqgIFoAp+ItS5
a=ice-ufrag:7bec20f6
a=ice-pwd:4b683609
a=candidate:Hac1637b2 1 UDP 2130706431 172.22.55.178 53530 typ host
a=candidate:H55ad1d9 1 UDP 2130706431 5.90.209.217 53530 typ host
a=candidate:Hac1637b2 2 UDP 2130706430 172.22.55.178 58436 typ host
a=candidate:H55ad1d9 2 UDP 2130706430 5.90.209.217 58436 typ host
2013-02-28 13:07:04.618122 [DEBUG] sofia_glue.c:4978 Set Remote Key [1 AES_CM_128_HMAC_SHA1_80 inline:fqwD6Slr4snIn2sJPbAtfR+sLr/VRQbTOmtdi7JH]
2013-02-28 13:07:04.618122 [DEBUG] sofia_glue.c:3155 Set Local Key [1 AES_CM_128_HMAC_SHA1_80 inline:L+JO67wbK0cKnCTZ7xDdwJy7QKIJfK4x3VB07M5s]
2013-02-28 13:07:04.618122 [DEBUG] sofia_glue.c:5137 Audio Codec Compare [PCMU:0:8000:20:64000]/[G722:9:8000:20:64000]
2013-02-28 13:07:04.618122 [DEBUG] sofia_glue.c:5137 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]
2013-02-28 13:07:04.618122 [DEBUG] sofia_glue.c:3093 Set Codec sofia/internal/101 at voice.wicube.net PCMU/8000 20 ms 160 samples 64000 bits
2013-02-28 13:07:04.618122 [DEBUG] switch_core_codec.c:111 sofia/internal/101 at voice.wicube.net Original read codec set to PCMU:0
2013-02-28 13:07:04.618122 [DEBUG] sofia_glue.c:5266 Set 2833 dtmf send/recv payload to 101
2013-02-28 13:07:04.618122 [DEBUG] sofia.c:5827 (sofia/internal/101 at voice.wicube.net) State Change CS_NEW -> CS_INIT
2013-02-28 13:07:04.618122 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/101 at voice.wicube.net) Running State Change CS_INIT
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/101 at voice.wicube.net) State INIT
2013-02-28 13:07:04.618122 [DEBUG] mod_sofia.c:86 sofia/internal/101 at voice.wicube.net SOFIA INIT
2013-02-28 13:07:04.618122 [DEBUG] mod_sofia.c:126 (sofia/internal/101 at voice.wicube.net) State Change CS_INIT -> CS_ROUTING
2013-02-28 13:07:04.618122 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/101 at voice.wicube.net) State INIT going to sleep
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/101 at voice.wicube.net) Running State Change CS_ROUTING
2013-02-28 13:07:04.618122 [DEBUG] switch_channel.c:2003 (sofia/internal/101 at voice.wicube.net) Callstate Change DOWN -> RINGING
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/101 at voice.wicube.net) State ROUTING
2013-02-28 13:07:04.618122 [DEBUG] mod_sofia.c:149 sofia/internal/101 at voice.wicube.net SOFIA ROUTING
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:117 sofia/internal/101 at voice.wicube.net Standard ROUTING
2013-02-28 13:07:04.618122 [INFO] mod_dialplan_xml.c:557 Processing 101 <101>->102 in context default
Dialplan: sofia/internal/101 at voice.wicube.net parsing [default->101] continue=false
Dialplan: sofia/internal/101 at voice.wicube.net Regex (FAIL) [101] destination_number(102) =~ /^101$/ break=on-false
Dialplan: sofia/internal/101 at voice.wicube.net parsing [default->102] continue=false
Dialplan: sofia/internal/101 at voice.wicube.net Regex (PASS) [102] destination_number(102) =~ /^102$/ break=on-false
Dialplan: sofia/internal/101 at voice.wicube.net Action bridge(USER/102 at 82.85.60.237)
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/101 at voice.wicube.net) State Change CS_ROUTING -> CS_EXECUTE
2013-02-28 13:07:04.618122 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/101 at voice.wicube.net) State ROUTING going to sleep
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/101 at voice.wicube.net) Running State Change CS_EXECUTE
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/101 at voice.wicube.net) State EXECUTE
2013-02-28 13:07:04.618122 [DEBUG] mod_sofia.c:242 sofia/internal/101 at voice.wicube.net SOFIA EXECUTE
2013-02-28 13:07:04.618122 [DEBUG] switch_core_state_machine.c:209 sofia/internal/101 at voice.wicube.net Standard EXECUTE
EXECUTE sofia/internal/101 at voice.wicube.net bridge(USER/102 at 82.85.60.237)
2013-02-28 13:07:04.639117 [DEBUG] switch_channel.c:1089 sofia/internal/101 at voice.wicube.net EXPORTING[export_vars] [domain_name]=[82.85.60.237] to event
2013-02-28 13:07:04.639117 [DEBUG] switch_ivr_originate.c:2022 Parsing global variables
2013-02-28 13:07:04.639117 [DEBUG] switch_channel.c:1089 sofia/internal/101 at voice.wicube.net EXPORTING[export_vars] [domain_name]=[82.85.60.237] to event
2013-02-28 13:07:04.639117 [DEBUG] switch_ivr_originate.c:2022 Parsing global variables
2013-02-28 13:07:04.639117 [DEBUG] switch_event.c:1608 Parsing variable [sip_invite_domain]=[82.85.60.237]
2013-02-28 13:07:04.639117 [DEBUG] switch_event.c:1608 Parsing variable [presence_id]=[102 at 82.85.60.237]
2013-02-28 13:07:04.639117 [NOTICE] switch_channel.c:968 New Channel sofia/internal/sip:102 at 85.18.36.68:55272 [3d9f6736-81a2-11e2-aca8-ad22efd2ace4]
2013-02-28 13:07:04.639117 [DEBUG] mod_sofia.c:4970 (sofia/internal/sip:102 at 85.18.36.68:55272) State Change CS_NEW -> CS_INIT
2013-02-28 13:07:04.639117 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [BREAK]
2013-02-28 13:07:04.639117 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:102 at 85.18.36.68:55272) Running State Change CS_INIT
2013-02-28 13:07:04.639117 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:102 at 85.18.36.68:55272) State INIT
2013-02-28 13:07:04.639117 [DEBUG] mod_sofia.c:86 sofia/internal/sip:102 at 85.18.36.68:55272 SOFIA INIT
2013-02-28 13:07:04.639117 [DEBUG] sofia_glue.c:2618 sip:102 at 85.18.36.68:55272;transport=tls;rinstance=2804dee11a135346 Setting proxy route to sofia/internal/sip:102 at 85.18.36.68:55272
2013-02-28 13:07:04.639117 [DEBUG] sofia_glue.c:2647 Local SDP:
v=0
o=FreeSWITCH 1362024826 1362024827 IN IP4 82.85.60.237
s=FreeSWITCH
c=IN IP4 82.85.60.237
t=0 0
m=audio 28398 RTP/AVP 0 9 8 3 101 13
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
2013-02-28 13:07:04.639117 [DEBUG] mod_sofia.c:126 (sofia/internal/sip:102 at 85.18.36.68:55272) State Change CS_INIT -> CS_ROUTING
2013-02-28 13:07:04.639117 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [BREAK]
2013-02-28 13:07:04.639117 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:102 at 85.18.36.68:55272) State INIT going to sleep
2013-02-28 13:07:04.639117 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:102 at 85.18.36.68:55272) Running State Change CS_ROUTING
2013-02-28 13:07:04.639117 [DEBUG] switch_channel.c:2003 (sofia/internal/sip:102 at 85.18.36.68:55272) Callstate Change DOWN -> RINGING
2013-02-28 13:07:04.639117 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:102 at 85.18.36.68:55272) State ROUTING
2013-02-28 13:07:04.639117 [DEBUG] mod_sofia.c:149 sofia/internal/sip:102 at 85.18.36.68:55272 SOFIA ROUTING
2013-02-28 13:07:04.639117 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/sip:102 at 85.18.36.68:55272) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2013-02-28 13:07:04.639117 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [BREAK]
2013-02-28 13:07:04.639117 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:102 at 85.18.36.68:55272) State ROUTING going to sleep
2013-02-28 13:07:04.639117 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:102 at 85.18.36.68:55272) Running State Change CS_CONSUME_MEDIA
2013-02-28 13:07:04.639117 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:102 at 85.18.36.68:55272) State CONSUME_MEDIA
2013-02-28 13:07:04.639117 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:102 at 85.18.36.68:55272) State CONSUME_MEDIA going to sleep
send 1228 bytes to tls/[85.18.36.68]:55272 at 12:27:39.310041:
------------------------------------------------------------------------
INVITE sip:102 at 85.18.36.68:55272;transport=tls;rinstance=2804dee11a135346 SIP/2.0
Via: SIP/2.0/TLS 82.85.60.237;branch=z9hG4bK18Q1U05eeZBrB
Max-Forwards: 69
From: "Vic Iphone" <sip:101 at 82.85.60.237>;tag=F6pSatDmH4BcH
To: <sip:102 at 85.18.36.68:55272;transport=tls;rinstance=2804dee11a135346>
Call-ID: 14fdf9be-fc45-1230-f395-005056b93f51
CSeq: 40691165 INVITE
Contact: <sip:mod_sofia at 82.85.60.237:5061;transport=tls>
User-Agent: FreeSWITCH-mod_sofia/1.2.6+git~20130104T154559Z~a4247651ca
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 207
X-FS-Support: update_display,send_info
Remote-Party-ID: "Vic Iphone" <sip:101 at 82.85.60.237>;party=calling;screen=yes;privacy=off
v=0
o=FreeSWITCH 1362024826 1362024827 IN IP4 82.85.60.237
s=FreeSWITCH
c=IN IP4 82.85.60.237
t=0 0
m=audio 28398 RTP/AVP 0 9 8 3 101 13
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
------------------------------------------------------------------------
2013-02-28 13:07:04.639117 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [BREAK]
2013-02-28 13:07:04.639117 [DEBUG] sofia.c:5599 Channel sofia/internal/sip:102 at 85.18.36.68:55272 entering state [calling][0]
recv 405 bytes from tls/[85.18.36.68]:55272 at 12:27:39.335865:
------------------------------------------------------------------------
SIP/2.0 415 Unsupported Media Type
Via: SIP/2.0/TLS 82.85.60.237;branch=z9hG4bK18Q1U05eeZBrB
To: <sip:102 at 85.18.36.68:55272;transport=tls;rinstance=2804dee11a135346>;tag=d85c4e58
From: "Vic Iphone"<sip:101 at 82.85.60.237>;tag=F6pSatDmH4BcH
Call-ID: 14fdf9be-fc45-1230-f395-005056b93f51
CSeq: 40691165 INVITE
Accept: application/sdp
User-Agent: Bria 3 release 3.5.0b stamp 69410
Content-Length: 0
------------------------------------------------------------------------
send 393 bytes to tls/[85.18.36.68]:55272 at 12:27:39.336009:
------------------------------------------------------------------------
ACK sip:102 at 85.18.36.68:55272;transport=tls;rinstance=2804dee11a135346 SIP/2.0
Via: SIP/2.0/TLS 82.85.60.237;branch=z9hG4bK18Q1U05eeZBrB
Max-Forwards: 69
From: "Vic Iphone" <sip:101 at 82.85.60.237>;tag=F6pSatDmH4BcH
To: <sip:102 at 85.18.36.68:55272;transport=tls;rinstance=2804dee11a135346>;tag=d85c4e58
Call-ID: 14fdf9be-fc45-1230-f395-005056b93f51
CSeq: 40691165 ACK
Content-Length: 0
------------------------------------------------------------------------
2013-02-28 13:07:04.658143 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [BREAK]
2013-02-28 13:07:04.658143 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [BREAK]
2013-02-28 13:07:04.658143 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [BREAK]
2013-02-28 13:07:04.658143 [DEBUG] sofia.c:5599 Channel sofia/internal/sip:102 at 85.18.36.68:55272 entering state [terminated][415]
2013-02-28 13:07:04.658143 [DEBUG] switch_channel.c:2994 (sofia/internal/sip:102 at 85.18.36.68:55272) Callstate Change RINGING -> HANGUP
2013-02-28 13:07:04.658143 [NOTICE] sofia.c:6383 Hangup sofia/internal/sip:102 at 85.18.36.68:55272 [CS_CONSUME_MEDIA] [SERVICE_NOT_IMPLEMENTED]
2013-02-28 13:07:04.658143 [DEBUG] switch_channel.c:3017 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [KILL]
2013-02-28 13:07:04.658143 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [BREAK]
2013-02-28 13:07:04.658143 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:102 at 85.18.36.68:55272) Running State Change CS_HANGUP
2013-02-28 13:07:04.658143 [DEBUG] switch_core_state_machine.c:667 (sofia/internal/sip:102 at 85.18.36.68:55272) State HANGUP
2013-02-28 13:07:04.658143 [DEBUG] mod_sofia.c:503 Channel sofia/internal/sip:102 at 85.18.36.68:55272 hanging up, cause: SERVICE_NOT_IMPLEMENTED
2013-02-28 13:07:04.658143 [DEBUG] switch_core_state_machine.c:48 sofia/internal/sip:102 at 85.18.36.68:55272 Standard HANGUP, cause: SERVICE_NOT_IMPLEMENTED
2013-02-28 13:07:04.658143 [DEBUG] switch_core_state_machine.c:667 (sofia/internal/sip:102 at 85.18.36.68:55272) State HANGUP going to sleep
2013-02-28 13:07:04.658143 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/sip:102 at 85.18.36.68:55272) State Change CS_HANGUP -> CS_REPORTING
2013-02-28 13:07:04.658143 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [BREAK]
2013-02-28 13:07:04.658143 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:102 at 85.18.36.68:55272) Running State Change CS_REPORTING
2013-02-28 13:07:04.658143 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/sip:102 at 85.18.36.68:55272) State REPORTING
2013-02-28 13:07:04.658143 [DEBUG] switch_core_state_machine.c:92 sofia/internal/sip:102 at 85.18.36.68:55272 Standard REPORTING, cause: SERVICE_NOT_IMPLEMENTED
2013-02-28 13:07:04.658143 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/sip:102 at 85.18.36.68:55272) State REPORTING going to sleep
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/sip:102 at 85.18.36.68:55272) State Change CS_REPORTING -> CS_DESTROY
2013-02-28 13:07:04.678496 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:102 at 85.18.36.68:55272 [BREAK]
2013-02-28 13:07:04.678496 [DEBUG] switch_core_session.c:1488 Session 22 (sofia/internal/sip:102 at 85.18.36.68:55272) Locked, Waiting on external entities
2013-02-28 13:07:04.678496 [DEBUG] switch_ivr_originate.c:3533 Originate Resulted in Error Cause: 79 [SERVICE_NOT_IMPLEMENTED]
2013-02-28 13:07:04.678496 [NOTICE] switch_ivr_originate.c:2608 Cannot create outgoing channel of type [USER] cause: [SERVICE_NOT_IMPLEMENTED]
2013-02-28 13:07:04.678496 [DEBUG] switch_ivr_originate.c:3533 Originate Resulted in Error Cause: 79 [SERVICE_NOT_IMPLEMENTED]
2013-02-28 13:07:04.678496 [NOTICE] switch_core_session.c:1506 Session 22 (sofia/internal/sip:102 at 85.18.36.68:55272) Ended
2013-02-28 13:07:04.678496 [NOTICE] switch_core_session.c:1510 Close Channel sofia/internal/sip:102 at 85.18.36.68:55272 [CS_DESTROY]
2013-02-28 13:07:04.678496 [INFO] mod_dptools.c:3052 Originate Failed. Cause: SERVICE_NOT_IMPLEMENTED
2013-02-28 13:07:04.678496 [DEBUG] switch_channel.c:2994 (sofia/internal/101 at voice.wicube.net) Callstate Change RINGING -> HANGUP
2013-02-28 13:07:04.678496 [NOTICE] mod_dptools.c:3172 Hangup sofia/internal/101 at voice.wicube.net [CS_EXECUTE] [SERVICE_NOT_IMPLEMENTED]
2013-02-28 13:07:04.678496 [DEBUG] switch_channel.c:3017 Send signal sofia/internal/101 at voice.wicube.net [KILL]
2013-02-28 13:07:04.678496 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.678496 [DEBUG] switch_core_session.c:2678 sofia/internal/101 at voice.wicube.net skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/101 at voice.wicube.net) State EXECUTE going to sleep
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/101 at voice.wicube.net) Running State Change CS_HANGUP
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:667 (sofia/internal/101 at voice.wicube.net) State HANGUP
2013-02-28 13:07:04.678496 [DEBUG] mod_sofia.c:497 sofia/internal/101 at voice.wicube.net Overriding SIP cause 501 with 415 from the other leg
2013-02-28 13:07:04.678496 [DEBUG] mod_sofia.c:503 Channel sofia/internal/101 at voice.wicube.net hanging up, cause: SERVICE_NOT_IMPLEMENTED
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:556 (sofia/internal/sip:102 at 85.18.36.68:55272) Callstate Change HANGUP -> DOWN
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:559 (sofia/internal/sip:102 at 85.18.36.68:55272) Running State Change CS_DESTROY
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/sip:102 at 85.18.36.68:55272) State DESTROY
2013-02-28 13:07:04.678496 [DEBUG] mod_sofia.c:396 sofia/internal/sip:102 at 85.18.36.68:55272 SOFIA DESTROY
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:99 sofia/internal/sip:102 at 85.18.36.68:55272 Standard DESTROY
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/sip:102 at 85.18.36.68:55272) State DESTROY going to sleep
2013-02-28 13:07:04.678496 [DEBUG] mod_sofia.c:633 Responding to INVITE with: 415
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:48 sofia/internal/101 at voice.wicube.net Standard HANGUP, cause: SERVICE_NOT_IMPLEMENTED
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:667 (sofia/internal/101 at voice.wicube.net) State HANGUP going to sleep
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/101 at voice.wicube.net) State Change CS_HANGUP -> CS_REPORTING
2013-02-28 13:07:04.678496 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/101 at voice.wicube.net) Running State Change CS_REPORTING
2013-02-28 13:07:04.678496 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/101 at voice.wicube.net) State REPORTING
send 918 bytes to tls/[85.18.36.68]:51187 at 12:27:39.358707:
------------------------------------------------------------------------
SIP/2.0 415 Unsupported Media Type
Via: SIP/2.0/TLS 85.18.36.68:51187;rport=51187;branch=z9hG4bKPjVkpmhYfPXXJ.MmmYQ62ufvtZD0K5i8Lf;alias
Max-Forwards: 70
From: "101" <sip:101 at voice.wicube.net>;tag=RQ-SQdhcZuhI5SYNSNKTY9F-9-.unsww
To: <sip:102 at voice.wicube.net>;tag=eXX08yvgmUNSN
Call-ID: 5xUNyMbEzeDbgO48GR2uPiITtdGkVHm9
CSeq: 31361 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.2.6+git~20130104T154559Z~a4247651ca
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Reason: Q.850;cause=79;text="SERVICE_NOT_IMPLEMENTED"
Content-Length: 0
Remote-Party-ID: "102" <sip:102 at voice.wicube.net>;party=calling;privacy=off;screen=no
------------------------------------------------------------------------
2013-02-28 13:07:04.718652 [DEBUG] switch_core_state_machine.c:92 sofia/internal/101 at voice.wicube.net Standard REPORTING, cause: SERVICE_NOT_IMPLEMENTED
2013-02-28 13:07:04.718652 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/101 at voice.wicube.net) State REPORTING going to sleep
2013-02-28 13:07:04.718652 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/101 at voice.wicube.net) State Change CS_REPORTING -> CS_DESTROY
2013-02-28 13:07:04.718652 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/101 at voice.wicube.net [BREAK]
2013-02-28 13:07:04.718652 [DEBUG] switch_core_session.c:1488 Session 21 (sofia/internal/101 at voice.wicube.net) Locked, Waiting on external entities
2013-02-28 13:07:04.718652 [NOTICE] switch_core_session.c:1506 Session 21 (sofia/internal/101 at voice.wicube.net) Ended
2013-02-28 13:07:04.718652 [NOTICE] switch_core_session.c:1510 Close Channel sofia/internal/101 at voice.wicube.net [CS_DESTROY]
2013-02-28 13:07:04.718652 [DEBUG] switch_core_state_machine.c:556 (sofia/internal/101 at voice.wicube.net) Callstate Change HANGUP -> DOWN
2013-02-28 13:07:04.718652 [DEBUG] switch_core_state_machine.c:559 (sofia/internal/101 at voice.wicube.net) Running State Change CS_DESTROY
2013-02-28 13:07:04.718652 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/101 at voice.wicube.net) State DESTROY
2013-02-28 13:07:04.718652 [DEBUG] mod_sofia.c:396 sofia/internal/101 at voice.wicube.net SOFIA DESTROY
2013-02-28 13:07:04.718652 [DEBUG] switch_core_state_machine.c:99 sofia/internal/101 at voice.wicube.net Standard DESTROY
2013-02-28 13:07:04.718652 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/101 at voice.wicube.net) State DESTROY going to sleep
recv 362 bytes from tls/[85.18.36.68]:51187 at 12:27:39.415726:
------------------------------------------------------------------------
ACK sip:102 at voice.wicube.net SIP/2.0
Via: SIP/2.0/TLS 85.18.36.68:51187;rport;branch=z9hG4bKPjVkpmhYfPXXJ.MmmYQ62ufvtZD0K5i8Lf;alias
Max-Forwards: 70
From: "101" <sip:101 at voice.wicube.net>;tag=RQ-SQdhcZuhI5SYNSNKTY9F-9-.unsww
To: <sip:102 at voice.wicube.net>;tag=eXX08yvgmUNSN
Call-ID: 5xUNyMbEzeDbgO48GR2uPiITtdGkVHm9
CSeq: 31361 ACK
Content-Length: 0
------------------------------------------------------------------------
-------------- next part --------------
freeswitch at internal>
recv 967 bytes from tls/[85.18.36.68]:55272 at 12:33:08.114408:
------------------------------------------------------------------------
INVITE sip:101 at voice.wicube.net;transport=tls SIP/2.0
Via: SIP/2.0/TLS 172.22.55.229:23309;branch=z9hG4bK-d8754z-925e617a4fdb6345-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:102 at 85.18.36.68:55272;transport=tls>
To: <sip:101 at voice.wicube.net>
From: <sip:102 at voice.wicube.net>;tag=6b71e108
Call-ID: NGEyMTUxZDI0YjUxNTI4MDljYjQ2NGQ2Y2ExMzRjODE
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Bria 3 release 3.5.0b stamp 69410
Content-Length: 393
v=0
o=- 1362054788086402 1 IN IP4 172.22.55.229
s=Bria 3 release 3.5.0b stamp 69410
c=IN IP4 172.22.55.229
b=AS:2064
t=0 0
m=audio 57780 RTP/SAVP 8 0 101
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:R2NgmDwTbaaxPRUFErm1Jcm1Ci074YlExkSiMN3Q
a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:R2NgmDwTbaaxPRUFErm1Jcm1Ci074YlExkSiMN3Q
a=sendrecv
------------------------------------------------------------------------
send 384 bytes to tls/[85.18.36.68]:55272 at 12:33:08.114775:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/TLS 172.22.55.229:23309;branch=z9hG4bK-d8754z-925e617a4fdb6345-1---d8754z-;rport=55272;received=85.18.36.68
From: <sip:102 at voice.wicube.net>;tag=6b71e108
To: <sip:101 at voice.wicube.net>
Call-ID: NGEyMTUxZDI0YjUxNTI4MDljYjQ2NGQ2Y2ExMzRjODE
CSeq: 1 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.2.6+git~20130104T154559Z~a4247651ca
Content-Length: 0
------------------------------------------------------------------------
2013-02-28 13:12:33.438185 [NOTICE] switch_channel.c:968 New Channel sofia/internal/102 at voice.wicube.net [019b7184-81a3-11e2-acb9-ad22efd2ace4]
2013-02-28 13:12:33.438185 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.438185 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.438185 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/102 at voice.wicube.net) Running State Change CS_NEW
2013-02-28 13:12:33.438185 [DEBUG] switch_core_state_machine.c:433 (sofia/internal/102 at voice.wicube.net) State NEW
2013-02-28 13:12:33.458149 [DEBUG] sofia.c:7729 IP 85.18.36.68 Rejected by acl "domains". Falling back to Digest auth.
2013-02-28 13:12:33.458149 [WARNING] sofia_reg.c:1502 SIP auth challenge (INVITE) on sofia profile 'internal' for [101 at voice.wicube.net] from ip 85.18.36.68
send 887 bytes to tls/[85.18.36.68]:55272 at 12:33:08.141400:
------------------------------------------------------------------------
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/TLS 172.22.55.229:23309;branch=z9hG4bK-d8754z-925e617a4fdb6345-1---d8754z-;rport=55272;received=85.18.36.68
From: <sip:102 at voice.wicube.net>;tag=6b71e108
To: <sip:101 at voice.wicube.net>;tag=QFaSHmF1X86Qg
Call-ID: NGEyMTUxZDI0YjUxNTI4MDljYjQ2NGQ2Y2ExMzRjODE
CSeq: 1 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.2.6+git~20130104T154559Z~a4247651ca
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Proxy-Authenticate: Digest realm="voice.wicube.net", nonce="019ea14c-81a3-11e2-acba-ad22efd2ace4", algorithm=MD5, qop="auth"
Content-Length: 0
------------------------------------------------------------------------
2013-02-28 13:12:33.458149 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.458149 [DEBUG] sofia.c:1750 detaching session 019b7184-81a3-11e2-acb9-ad22efd2ace4
recv 350 bytes from tls/[85.18.36.68]:55272 at 12:33:08.165867:
------------------------------------------------------------------------
ACK sip:101 at voice.wicube.net;transport=tls SIP/2.0
Via: SIP/2.0/TLS 172.22.55.229:23309;branch=z9hG4bK-d8754z-925e617a4fdb6345-1---d8754z-;rport
Max-Forwards: 70
To: <sip:101 at voice.wicube.net>;tag=QFaSHmF1X86Qg
From: <sip:102 at voice.wicube.net>;tag=6b71e108
Call-ID: NGEyMTUxZDI0YjUxNTI4MDljYjQ2NGQ2Y2ExMzRjODE
CSeq: 1 ACK
Content-Length: 0
------------------------------------------------------------------------
recv 1247 bytes from tls/[85.18.36.68]:55272 at 12:33:08.228403:
------------------------------------------------------------------------
INVITE sip:101 at voice.wicube.net;transport=tls SIP/2.0
Via: SIP/2.0/TLS 172.22.55.229:23309;branch=z9hG4bK-d8754z-1ed3ac4e4ed2fb0d-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:102 at 85.18.36.68:55272;transport=tls>
To: <sip:101 at voice.wicube.net>
From: <sip:102 at voice.wicube.net>;tag=6b71e108
Call-ID: NGEyMTUxZDI0YjUxNTI4MDljYjQ2NGQ2Y2ExMzRjODE
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
Content-Type: application/sdp
Proxy-Authorization: Digest username="102",realm="voice.wicube.net",nonce="019ea14c-81a3-11e2-acba-ad22efd2ace4",uri="sip:101 at voice.wicube.net;transport=tls",response="c4c265a7ed630f5baf61861f213ffa85",cnonce="c2d87f66e274b12b96063e5f6d1afa92",nc=00000001,qop=auth,algorithm=MD5
Supported: replaces
User-Agent: Bria 3 release 3.5.0b stamp 69410
Content-Length: 393
v=0
o=- 1362054788086402 1 IN IP4 172.22.55.229
s=Bria 3 release 3.5.0b stamp 69410
c=IN IP4 172.22.55.229
b=AS:2064
t=0 0
m=audio 57780 RTP/SAVP 8 0 101
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:R2NgmDwTbaaxPRUFErm1Jcm1Ci074YlExkSiMN3Q
a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:R2NgmDwTbaaxPRUFErm1Jcm1Ci074YlExkSiMN3Q
a=sendrecv
------------------------------------------------------------------------
send 384 bytes to tls/[85.18.36.68]:55272 at 12:33:08.228742:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/TLS 172.22.55.229:23309;branch=z9hG4bK-d8754z-1ed3ac4e4ed2fb0d-1---d8754z-;rport=55272;received=85.18.36.68
From: <sip:102 at voice.wicube.net>;tag=6b71e108
To: <sip:101 at voice.wicube.net>
Call-ID: NGEyMTUxZDI0YjUxNTI4MDljYjQ2NGQ2Y2ExMzRjODE
CSeq: 2 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.2.6+git~20130104T154559Z~a4247651ca
Content-Length: 0
------------------------------------------------------------------------
2013-02-28 13:12:33.558196 [DEBUG] sofia.c:1842 Re-attaching to session 019b7184-81a3-11e2-acb9-ad22efd2ace4
2013-02-28 13:12:33.558196 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.558196 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.558196 [DEBUG] sofia.c:7729 IP 85.18.36.68 Rejected by acl "domains". Falling back to Digest auth.
2013-02-28 13:12:33.578143 [DEBUG] sofia.c:5599 Channel sofia/internal/102 at voice.wicube.net entering state [received][100]
2013-02-28 13:12:33.578143 [DEBUG] sofia.c:5610 Remote SDP:
v=0
o=- 1362054788086402 1 IN IP4 172.22.55.229
s=Bria 3 release 3.5.0b stamp 69410
c=IN IP4 172.22.55.229
b=AS:2064
t=0 0
m=audio 57780 RTP/SAVP 8 0 101
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:R2NgmDwTbaaxPRUFErm1Jcm1Ci074YlExkSiMN3Q
a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:R2NgmDwTbaaxPRUFErm1Jcm1Ci074YlExkSiMN3Q
2013-02-28 13:12:33.578143 [DEBUG] sofia_glue.c:4978 Set Remote Key [1 AES_CM_128_HMAC_SHA1_80 inline:R2NgmDwTbaaxPRUFErm1Jcm1Ci074YlExkSiMN3Q]
2013-02-28 13:12:33.578143 [DEBUG] sofia_glue.c:3155 Set Local Key [1 AES_CM_128_HMAC_SHA1_80 inline:ctGA+qVyHINVQ/LypSDfJ+OdCPJPp57nGMPtm/nw]
2013-02-28 13:12:33.578143 [DEBUG] sofia_glue.c:5137 Audio Codec Compare [PCMA:8:8000:20:64000]/[G722:9:8000:20:64000]
2013-02-28 13:12:33.578143 [DEBUG] sofia_glue.c:5137 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]
2013-02-28 13:12:33.578143 [DEBUG] sofia_glue.c:5137 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2013-02-28 13:12:33.578143 [DEBUG] sofia_glue.c:3093 Set Codec sofia/internal/102 at voice.wicube.net PCMA/8000 20 ms 160 samples 64000 bits
2013-02-28 13:12:33.578143 [DEBUG] switch_core_codec.c:111 sofia/internal/102 at voice.wicube.net Original read codec set to PCMA:8
2013-02-28 13:12:33.578143 [DEBUG] sofia_glue.c:5266 Set 2833 dtmf send/recv payload to 101
2013-02-28 13:12:33.578143 [DEBUG] sofia.c:5827 (sofia/internal/102 at voice.wicube.net) State Change CS_NEW -> CS_INIT
2013-02-28 13:12:33.578143 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/102 at voice.wicube.net) Running State Change CS_INIT
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/102 at voice.wicube.net) State INIT
2013-02-28 13:12:33.578143 [DEBUG] mod_sofia.c:86 sofia/internal/102 at voice.wicube.net SOFIA INIT
2013-02-28 13:12:33.578143 [DEBUG] mod_sofia.c:126 (sofia/internal/102 at voice.wicube.net) State Change CS_INIT -> CS_ROUTING
2013-02-28 13:12:33.578143 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/102 at voice.wicube.net) State INIT going to sleep
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/102 at voice.wicube.net) Running State Change CS_ROUTING
2013-02-28 13:12:33.578143 [DEBUG] switch_channel.c:2003 (sofia/internal/102 at voice.wicube.net) Callstate Change DOWN -> RINGING
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/102 at voice.wicube.net) State ROUTING
2013-02-28 13:12:33.578143 [DEBUG] mod_sofia.c:149 sofia/internal/102 at voice.wicube.net SOFIA ROUTING
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:117 sofia/internal/102 at voice.wicube.net Standard ROUTING
2013-02-28 13:12:33.578143 [INFO] mod_dialplan_xml.c:557 Processing 102 <102>->101 in context default
Dialplan: sofia/internal/102 at voice.wicube.net parsing [default->101] continue=false
Dialplan: sofia/internal/102 at voice.wicube.net Regex (PASS) [101] destination_number(101) =~ /^101$/ break=on-false
Dialplan: sofia/internal/102 at voice.wicube.net Action bridge(USER/101 at 82.85.60.237)
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/102 at voice.wicube.net) State Change CS_ROUTING -> CS_EXECUTE
2013-02-28 13:12:33.578143 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/102 at voice.wicube.net) State ROUTING going to sleep
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/102 at voice.wicube.net) Running State Change CS_EXECUTE
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/102 at voice.wicube.net) State EXECUTE
2013-02-28 13:12:33.578143 [DEBUG] mod_sofia.c:242 sofia/internal/102 at voice.wicube.net SOFIA EXECUTE
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:209 sofia/internal/102 at voice.wicube.net Standard EXECUTE
EXECUTE sofia/internal/102 at voice.wicube.net bridge(USER/101 at 82.85.60.237)
2013-02-28 13:12:33.578143 [DEBUG] switch_channel.c:1089 sofia/internal/102 at voice.wicube.net EXPORTING[export_vars] [domain_name]=[82.85.60.237] to event
2013-02-28 13:12:33.578143 [DEBUG] switch_ivr_originate.c:2022 Parsing global variables
2013-02-28 13:12:33.578143 [DEBUG] switch_channel.c:1089 sofia/internal/102 at voice.wicube.net EXPORTING[export_vars] [domain_name]=[82.85.60.237] to event
2013-02-28 13:12:33.578143 [DEBUG] switch_ivr_originate.c:2022 Parsing global variables
2013-02-28 13:12:33.578143 [DEBUG] switch_event.c:1608 Parsing variable [sip_invite_domain]=[82.85.60.237]
2013-02-28 13:12:33.578143 [DEBUG] switch_event.c:1608 Parsing variable [presence_id]=[101 at 82.85.60.237]
2013-02-28 13:12:33.578143 [NOTICE] switch_channel.c:968 New Channel sofia/internal/sip:101 at 85.18.36.68:51187 [01b12f2e-81a3-11e2-acc3-ad22efd2ace4]
2013-02-28 13:12:33.578143 [DEBUG] mod_sofia.c:4970 (sofia/internal/sip:101 at 85.18.36.68:51187) State Change CS_NEW -> CS_INIT
2013-02-28 13:12:33.578143 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [BREAK]
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:101 at 85.18.36.68:51187) Running State Change CS_INIT
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:101 at 85.18.36.68:51187) State INIT
2013-02-28 13:12:33.578143 [DEBUG] mod_sofia.c:86 sofia/internal/sip:101 at 85.18.36.68:51187 SOFIA INIT
2013-02-28 13:12:33.578143 [DEBUG] sofia_glue.c:2618 sip:101 at 85.18.36.68:51187;transport=TLS;ob Setting proxy route to sofia/internal/sip:101 at 85.18.36.68:51187
2013-02-28 13:12:33.578143 [DEBUG] sofia_glue.c:2647 Local SDP:
v=0
o=FreeSWITCH 1362036675 1362036676 IN IP4 82.85.60.237
s=FreeSWITCH
c=IN IP4 82.85.60.237
t=0 0
m=audio 16878 RTP/AVP 8 9 0 3 101 13
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
2013-02-28 13:12:33.578143 [DEBUG] mod_sofia.c:126 (sofia/internal/sip:101 at 85.18.36.68:51187) State Change CS_INIT -> CS_ROUTING
2013-02-28 13:12:33.578143 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [BREAK]
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:101 at 85.18.36.68:51187) State INIT going to sleep
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:101 at 85.18.36.68:51187) Running State Change CS_ROUTING
2013-02-28 13:12:33.578143 [DEBUG] switch_channel.c:2003 (sofia/internal/sip:101 at 85.18.36.68:51187) Callstate Change DOWN -> RINGING
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:101 at 85.18.36.68:51187) State ROUTING
2013-02-28 13:12:33.578143 [DEBUG] mod_sofia.c:149 sofia/internal/sip:101 at 85.18.36.68:51187 SOFIA ROUTING
2013-02-28 13:12:33.578143 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/sip:101 at 85.18.36.68:51187) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2013-02-28 13:12:33.578143 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [BREAK]
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:101 at 85.18.36.68:51187) State ROUTING going to sleep
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:101 at 85.18.36.68:51187) Running State Change CS_CONSUME_MEDIA
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:101 at 85.18.36.68:51187) State CONSUME_MEDIA
2013-02-28 13:12:33.578143 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:101 at 85.18.36.68:51187) State CONSUME_MEDIA going to sleep
send 1182 bytes to tls/[85.18.36.68]:51187 at 12:33:08.259885:
------------------------------------------------------------------------
INVITE sip:101 at 85.18.36.68:51187;transport=TLS;ob SIP/2.0
Via: SIP/2.0/TLS 82.85.60.237;branch=z9hG4bK3taKZp7N8grXj
Max-Forwards: 69
From: "Vic Mac Pro" <sip:102 at 82.85.60.237>;tag=S1vaNaH8QtKXQ
To: <sip:101 at 85.18.36.68:51187;transport=TLS;ob>
Call-ID: d90fbc70-fc45-1230-f395-005056b93f51
CSeq: 40691330 INVITE
Contact: <sip:mod_sofia at 82.85.60.237:5061;transport=tls>
User-Agent: FreeSWITCH-mod_sofia/1.2.6+git~20130104T154559Z~a4247651ca
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 207
X-FS-Support: update_display,send_info
Remote-Party-ID: "Vic Mac Pro" <sip:102 at 82.85.60.237>;party=calling;screen=yes;privacy=off
v=0
o=FreeSWITCH 1362036675 1362036676 IN IP4 82.85.60.237
s=FreeSWITCH
c=IN IP4 82.85.60.237
t=0 0
m=audio 16878 RTP/AVP 8 9 0 3 101 13
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
------------------------------------------------------------------------
2013-02-28 13:12:33.578143 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [BREAK]
2013-02-28 13:12:33.578143 [DEBUG] sofia.c:5599 Channel sofia/internal/sip:101 at 85.18.36.68:51187 entering state [calling][0]
recv 341 bytes from tls/[85.18.36.68]:51187 at 12:33:08.332434:
------------------------------------------------------------------------
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TLS 82.85.60.237;received=82.85.60.237;branch=z9hG4bK3taKZp7N8grXj;alias
Call-ID: d90fbc70-fc45-1230-f395-005056b93f51
From: "Vic Mac Pro" <sip:102 at 82.85.60.237>;tag=S1vaNaH8QtKXQ
To: <sip:101 at 85.18.36.68;ob>;tag=GSUFFx7sd2US6fRO3fWnz40WRNdua4Eo
CSeq: 40691330 INVITE
Content-Length: 0
------------------------------------------------------------------------
send 350 bytes to tls/[85.18.36.68]:51187 at 12:33:08.332571:
------------------------------------------------------------------------
ACK sip:101 at 85.18.36.68:51187;transport=TLS;ob SIP/2.0
Via: SIP/2.0/TLS 82.85.60.237;branch=z9hG4bK3taKZp7N8grXj
Max-Forwards: 69
From: "Vic Mac Pro" <sip:102 at 82.85.60.237>;tag=S1vaNaH8QtKXQ
To: <sip:101 at 85.18.36.68;ob>;tag=GSUFFx7sd2US6fRO3fWnz40WRNdua4Eo
Call-ID: d90fbc70-fc45-1230-f395-005056b93f51
CSeq: 40691330 ACK
Content-Length: 0
------------------------------------------------------------------------
2013-02-28 13:12:33.658123 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [BREAK]
2013-02-28 13:12:33.658123 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [BREAK]
2013-02-28 13:12:33.658123 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [BREAK]
2013-02-28 13:12:33.658123 [DEBUG] sofia.c:5599 Channel sofia/internal/sip:101 at 85.18.36.68:51187 entering state [terminated][488]
2013-02-28 13:12:33.658123 [DEBUG] switch_channel.c:2994 (sofia/internal/sip:101 at 85.18.36.68:51187) Callstate Change RINGING -> HANGUP
2013-02-28 13:12:33.658123 [NOTICE] sofia.c:6383 Hangup sofia/internal/sip:101 at 85.18.36.68:51187 [CS_CONSUME_MEDIA] [INCOMPATIBLE_DESTINATION]
2013-02-28 13:12:33.658123 [DEBUG] switch_channel.c:3017 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [KILL]
2013-02-28 13:12:33.658123 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [BREAK]
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:101 at 85.18.36.68:51187) Running State Change CS_HANGUP
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:667 (sofia/internal/sip:101 at 85.18.36.68:51187) State HANGUP
2013-02-28 13:12:33.658123 [DEBUG] mod_sofia.c:503 Channel sofia/internal/sip:101 at 85.18.36.68:51187 hanging up, cause: INCOMPATIBLE_DESTINATION
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:48 sofia/internal/sip:101 at 85.18.36.68:51187 Standard HANGUP, cause: INCOMPATIBLE_DESTINATION
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:667 (sofia/internal/sip:101 at 85.18.36.68:51187) State HANGUP going to sleep
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/sip:101 at 85.18.36.68:51187) State Change CS_HANGUP -> CS_REPORTING
2013-02-28 13:12:33.658123 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [BREAK]
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:101 at 85.18.36.68:51187) Running State Change CS_REPORTING
2013-02-28 13:12:33.658123 [DEBUG] switch_ivr_originate.c:3533 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]
2013-02-28 13:12:33.658123 [NOTICE] switch_ivr_originate.c:2608 Cannot create outgoing channel of type [USER] cause: [INCOMPATIBLE_DESTINATION]
2013-02-28 13:12:33.658123 [DEBUG] switch_ivr_originate.c:3533 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/sip:101 at 85.18.36.68:51187) State REPORTING
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:92 sofia/internal/sip:101 at 85.18.36.68:51187 Standard REPORTING, cause: INCOMPATIBLE_DESTINATION
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/sip:101 at 85.18.36.68:51187) State REPORTING going to sleep
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/sip:101 at 85.18.36.68:51187) State Change CS_REPORTING -> CS_DESTROY
2013-02-28 13:12:33.658123 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/sip:101 at 85.18.36.68:51187 [BREAK]
2013-02-28 13:12:33.658123 [DEBUG] switch_core_session.c:1488 Session 24 (sofia/internal/sip:101 at 85.18.36.68:51187) Locked, Waiting on external entities
2013-02-28 13:12:33.658123 [NOTICE] switch_core_session.c:1506 Session 24 (sofia/internal/sip:101 at 85.18.36.68:51187) Ended
2013-02-28 13:12:33.658123 [NOTICE] switch_core_session.c:1510 Close Channel sofia/internal/sip:101 at 85.18.36.68:51187 [CS_DESTROY]
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:556 (sofia/internal/sip:101 at 85.18.36.68:51187) Callstate Change HANGUP -> DOWN
2013-02-28 13:12:33.658123 [INFO] mod_dptools.c:3052 Originate Failed. Cause: INCOMPATIBLE_DESTINATION
2013-02-28 13:12:33.658123 [DEBUG] switch_channel.c:2994 (sofia/internal/102 at voice.wicube.net) Callstate Change RINGING -> HANGUP
2013-02-28 13:12:33.658123 [NOTICE] mod_dptools.c:3172 Hangup sofia/internal/102 at voice.wicube.net [CS_EXECUTE] [INCOMPATIBLE_DESTINATION]
2013-02-28 13:12:33.658123 [DEBUG] switch_channel.c:3017 Send signal sofia/internal/102 at voice.wicube.net [KILL]
2013-02-28 13:12:33.658123 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:559 (sofia/internal/sip:101 at 85.18.36.68:51187) Running State Change CS_DESTROY
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/sip:101 at 85.18.36.68:51187) State DESTROY
2013-02-28 13:12:33.658123 [DEBUG] mod_sofia.c:396 sofia/internal/sip:101 at 85.18.36.68:51187 SOFIA DESTROY
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:99 sofia/internal/sip:101 at 85.18.36.68:51187 Standard DESTROY
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/sip:101 at 85.18.36.68:51187) State DESTROY going to sleep
2013-02-28 13:12:33.658123 [DEBUG] switch_core_session.c:2678 sofia/internal/102 at voice.wicube.net skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/102 at voice.wicube.net) State EXECUTE going to sleep
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/102 at voice.wicube.net) Running State Change CS_HANGUP
2013-02-28 13:12:33.658123 [DEBUG] switch_core_state_machine.c:667 (sofia/internal/102 at voice.wicube.net) State HANGUP
2013-02-28 13:12:33.658123 [DEBUG] mod_sofia.c:497 sofia/internal/102 at voice.wicube.net Overriding SIP cause 488 with 488 from the other leg
2013-02-28 13:12:33.658123 [DEBUG] mod_sofia.c:503 Channel sofia/internal/102 at voice.wicube.net hanging up, cause: INCOMPATIBLE_DESTINATION
2013-02-28 13:12:33.678270 [DEBUG] mod_sofia.c:633 Responding to INVITE with: 488
2013-02-28 13:12:33.678270 [DEBUG] switch_core_state_machine.c:48 sofia/internal/102 at voice.wicube.net Standard HANGUP, cause: INCOMPATIBLE_DESTINATION
2013-02-28 13:12:33.678270 [DEBUG] switch_core_state_machine.c:667 (sofia/internal/102 at voice.wicube.net) State HANGUP going to sleep
2013-02-28 13:12:33.678270 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/102 at voice.wicube.net) State Change CS_HANGUP -> CS_REPORTING
2013-02-28 13:12:33.678270 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.678270 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/102 at voice.wicube.net) Running State Change CS_REPORTING
2013-02-28 13:12:33.678270 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/102 at voice.wicube.net) State REPORTING
send 912 bytes to tls/[85.18.36.68]:55272 at 12:33:08.356137:
------------------------------------------------------------------------
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TLS 172.22.55.229:23309;branch=z9hG4bK-d8754z-1ed3ac4e4ed2fb0d-1---d8754z-;rport=55272;received=85.18.36.68
Max-Forwards: 70
From: <sip:102 at voice.wicube.net>;tag=6b71e108
To: <sip:101 at voice.wicube.net>;tag=rr3HKF04tHXac
Call-ID: NGEyMTUxZDI0YjUxNTI4MDljYjQ2NGQ2Y2ExMzRjODE
CSeq: 2 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.2.6+git~20130104T154559Z~a4247651ca
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Reason: Q.850;cause=88;text="INCOMPATIBLE_DESTINATION"
Content-Length: 0
Remote-Party-ID: "101" <sip:101 at voice.wicube.net>;party=calling;privacy=off;screen=no
------------------------------------------------------------------------
2013-02-28 13:12:33.721161 [DEBUG] switch_core_state_machine.c:92 sofia/internal/102 at voice.wicube.net Standard REPORTING, cause: INCOMPATIBLE_DESTINATION
2013-02-28 13:12:33.721161 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/102 at voice.wicube.net) State REPORTING going to sleep
2013-02-28 13:12:33.721161 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/102 at voice.wicube.net) State Change CS_REPORTING -> CS_DESTROY
2013-02-28 13:12:33.721161 [DEBUG] switch_core_session.c:1283 Send signal sofia/internal/102 at voice.wicube.net [BREAK]
2013-02-28 13:12:33.721161 [DEBUG] switch_core_session.c:1488 Session 23 (sofia/internal/102 at voice.wicube.net) Locked, Waiting on external entities
2013-02-28 13:12:33.721161 [NOTICE] switch_core_session.c:1506 Session 23 (sofia/internal/102 at voice.wicube.net) Ended
2013-02-28 13:12:33.721161 [NOTICE] switch_core_session.c:1510 Close Channel sofia/internal/102 at voice.wicube.net [CS_DESTROY]
2013-02-28 13:12:33.721161 [DEBUG] switch_core_state_machine.c:556 (sofia/internal/102 at voice.wicube.net) Callstate Change HANGUP -> DOWN
2013-02-28 13:12:33.721161 [DEBUG] switch_core_state_machine.c:559 (sofia/internal/102 at voice.wicube.net) Running State Change CS_DESTROY
2013-02-28 13:12:33.721161 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/102 at voice.wicube.net) State DESTROY
2013-02-28 13:12:33.721161 [DEBUG] mod_sofia.c:396 sofia/internal/102 at voice.wicube.net SOFIA DESTROY
2013-02-28 13:12:33.721161 [DEBUG] switch_core_state_machine.c:99 sofia/internal/102 at voice.wicube.net Standard DESTROY
2013-02-28 13:12:33.721161 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/102 at voice.wicube.net) State DESTROY going to sleep
recv 350 bytes from tls/[85.18.36.68]:55272 at 12:33:08.426513:
------------------------------------------------------------------------
ACK sip:101 at voice.wicube.net;transport=tls SIP/2.0
Via: SIP/2.0/TLS 172.22.55.229:23309;branch=z9hG4bK-d8754z-1ed3ac4e4ed2fb0d-1---d8754z-;rport
Max-Forwards: 70
To: <sip:101 at voice.wicube.net>;tag=rr3HKF04tHXac
From: <sip:102 at voice.wicube.net>;tag=6b71e108
Call-ID: NGEyMTUxZDI0YjUxNTI4MDljYjQ2NGQ2Y2ExMzRjODE
CSeq: 2 ACK
Content-Length: 0
------------------------------------------------------------------------
Join us at ClueCon 2011 Aug 9-11, 2011
More information about the FreeSWITCH-users
mailing list