[Freeswitch-users] Conference Dial In Isn't Working (mod_conference)

Jan Riedinger riedinger at sns.eu
Sat Apr 3 10:00:34 PDT 2010


Here is the missing debug information.

Thanks
    Jan

freeswitch at ...> recv 839 bytes from udp/[XXX.XX.XX.X6]:5060 at 
16:48:12.118650:
   ------------------------------------------------------------------------
   INVITE sip:49331YYYYYY at XXX.XX.XX.X7:5060;user=phone SIP/2.0
   Via: SIP/2.0/UDP 
XXX.XX.XX.X6:5060;branch=z9hG4bK-34ff11004c71ff10ff000024ff0c6dff
   From: 
<sip:49XXXXXXXX6 at XXX.XX.XX.X6;user=phone>;tag=44ff11004c71ff10ff000024ff0c6dff
   To: <sip:49331YYYYYY at XXX.XX.XX.X7:5060;user=phone>
   Call-ID: 9aef11004c71b710800000248c0c6d9e at DOMAIN_ORIG
   CSeq: 1 INVITE
   Contact: <sip:49XXXXXXXX6 at XXX.XX.XX.X6;user=phone>
   Max-Forwards: 10
   User-Agent: MERA MSIP v.1.0.2
   Cisco-Guid: 2962728880-1061163487-2855600256-2188435832
   Content-Type: application/sdp
   Content-Length:   264

   v=0
   o=- 1270313292 1270313292 IN IP4 XXX.XX.XX.X6
   s=-
   c=IN IP4 XXX.XX.XX.X6
   t=0 0
   m=audio 22284 RTP/AVP 18 4 8 0 101
   a=rtpmap:18 G729/8000
   a=rtpmap:4 G723/8000
   a=rtpmap:8 PCMA/8000
   a=rtpmap:0 PCMU/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
send 392 bytes to udp/[XXX.XX.XX.X6]:5060 at 16:48:12.118936:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 
XXX.XX.XX.X6:5060;branch=z9hG4bK-34ff11004c71ff10ff000024ff0c6dff
   From: 
<sip:49XXXXXXXX6 at XXX.XX.XX.X6;user=phone>;tag=44ff11004c71ff10ff000024ff0c6dff
   To: <sip:49331YYYYYY at XXX.XX.XX.X7:5060;user=phone>
   Call-ID: 9aef11004c71b710800000248c0c6d9e at DOMAIN_ORIG
   CSeq: 1 INVITE
   User-Agent: FreeSWITCH-mod_sofia/1.0.git-exportiert
   Content-Length: 0

   ------------------------------------------------------------------------
2010-04-03 18:48:12.116629 [NOTICE] switch_channel.c:669 New Channel 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 
[d1242848-5588-4083-acea-062fd74e5f66]
2010-04-03 18:48:12.116629 [DEBUG] sofia.c:4153 Channel 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 entering state [received][100]
2010-04-03 18:48:12.116629 [DEBUG] sofia.c:4164 Remote SDP:
v=0
o=- 1270313292 1270313292 IN IP4 XXX.XX.XX.X6
s=-
c=IN IP4 XXX.XX.XX.X6
t=0 0
m=audio 22284 RTP/AVP 18 4 8 0 101
a=rtpmap:18 G729/8000
a=rtpmap:4 G723/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G729:18:8000:20]/[G7221:115:32000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G729:18:8000:20]/[G7221:107:16000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G729:18:8000:20]/[G722:9:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G729:18:8000:20]/[PCMU:0:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G729:18:8000:20]/[PCMA:8:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:314 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) Running State Change CS_NEW
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G729:18:8000:20]/[GSM:3:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G723:4:8000:20]/[G7221:115:32000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G723:4:8000:20]/[G7221:107:16000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G723:4:8000:20]/[G722:9:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G723:4:8000:20]/[PCMU:0:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G723:4:8000:20]/[PCMA:8:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[G723:4:8000:20]/[GSM:3:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[PCMA:8:8000:20]/[G7221:115:32000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[PCMA:8:8000:20]/[G7221:107:16000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[PCMA:8:8000:20]/[G722:9:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[PCMA:8:8000:20]/[PCMU:0:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3585 Audio Codec Compare 
[PCMA:8:8000:20]/[PCMA:8:8000:20]
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:2354 Set Codec 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 PCMA/8000 20 ms 160 samples
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:3524 Set 2833 dtmf 
send/recv payload to 101
2010-04-03 18:48:12.119630 [DEBUG] sofia.c:4310 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State Change CS_NEW -> CS_INIT
2010-04-03 18:48:12.119630 [DEBUG] switch_core_session.c:1018 Send 
signal sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [BREAK]
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:320 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State NEW
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:314 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) Running State Change CS_INIT
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:338 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State INIT
2010-04-03 18:48:12.119630 [DEBUG] mod_sofia.c:83 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 SOFIA INIT
2010-04-03 18:48:12.119630 [DEBUG] mod_sofia.c:117 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State Change CS_INIT -> CS_ROUTING
2010-04-03 18:48:12.119630 [DEBUG] switch_core_session.c:1018 Send 
signal sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [BREAK]
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:338 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State INIT going to sleep
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:314 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) Running State Change CS_ROUTING
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:341 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State ROUTING
2010-04-03 18:48:12.119630 [DEBUG] mod_sofia.c:140 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 SOFIA ROUTING
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:77 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Standard ROUTING
2010-04-03 18:48:12.119630 [INFO] mod_dialplan_xml.c:418 Processing 
49XXXXXXXX6->49331YYYYYY in context public
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 parsing 
[public->unloop] continue=false
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Regex (PASS) [unloop] 
${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Regex (FAIL) [unloop] 
${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 parsing 
[public->outside_call] continue=true
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Absolute Condition 
[outside_call]
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Action 
set(outside_call=true)
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 parsing 
[public->call_debug] continue=true
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Regex (FAIL) 
[call_debug] ${call_debug}(false) =~ /^true$/ break=never
...
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 parsing 
[public->sns_conference] continue=false
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Regex (PASS) 
[sns_conference] destination_number(49331YYYYYY) =~ /^(49331YYYYYY)$/ 
break=on-false
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Action answer()
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Action 
set(conference_enforce_security=false)
Dialplan: sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Action 
conference(49331YYYYYY-${domain_name}@default)
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:119 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State Change CS_ROUTING -> 
CS_EXECUTE
2010-04-03 18:48:12.119630 [DEBUG] switch_core_session.c:1018 Send 
signal sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [BREAK]
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:341 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State ROUTING going to sleep
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:314 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) Running State Change CS_EXECUTE
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:348 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State EXECUTE
2010-04-03 18:48:12.119630 [DEBUG] mod_sofia.c:226 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 SOFIA EXECUTE
2010-04-03 18:48:12.119630 [DEBUG] switch_core_state_machine.c:157 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Standard EXECUTE
EXECUTE sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 set(outside_call=true)
2010-04-03 18:48:12.119630 [DEBUG] mod_dptools.c:816 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 SET [outside_call]=[true]
EXECUTE sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 answer()
2010-04-03 18:48:12.119630 [DEBUG] sofia_glue.c:2594 AUDIO RTP 
[sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6] XXX.XX.XX.X7 port 21986 -> 
XXX.XX.XX.X6 port 22284 codec: 8 ms: 20
2010-04-03 18:48:12.119630 [DEBUG] switch_rtp.c:1182 Starting timer 
[soft] 160 bytes per 20ms
2010-04-03 18:48:12.122631 [DEBUG] sofia_glue.c:2774 Set 2833 dtmf send 
payload to 101
2010-04-03 18:48:12.122631 [DEBUG] sofia_glue.c:2779 Set 2833 dtmf 
receive payload to 101
2010-04-03 18:48:12.122631 [DEBUG] mod_sofia.c:636 Local SDP 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6:
v=0
o=FreeSWITCH 1270291306 1270291307 IN IP4 XXX.XX.XX.X7
s=FreeSWITCH
c=IN IP4 XXX.XX.XX.X7
t=0 0
m=audio 21986 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

2010-04-03 18:48:12.122631 [DEBUG] switch_core_session.c:638 Send signal 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [BREAK]
2010-04-03 18:48:12.122631 [NOTICE] mod_dptools.c:719 Channel 
[sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6] has been answered
send 1068 bytes to udp/[XXX.XX.XX.X6]:5060 at 16:48:12.124920:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 
XXX.XX.XX.X6:5060;branch=z9hG4bK-34ff11004c71ff10ff000024ff0c6dff
   From: 
<sip:49XXXXXXXX6 at XXX.XX.XX.X6;user=phone>;tag=44ff11004c71ff10ff000024ff0c6dff
   To: <sip:49331YYYYYY at XXX.XX.XX.X7:5060;user=phone>;tag=Uv2Z4H5vNFyej
   Call-ID: 9aef11004c71b710800000248c0c6d9e at DOMAIN_ORIG
   CSeq: 1 INVITE
   Contact: <sip:49331YYYYYY at XXX.XX.XX.X7:5060;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.0.git-exportiert
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, 
REGISTER, REFER, NOTIFY
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, refer
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 247
   Remote-Party-ID: "49331YYYYYY" 
<sip:49331YYYYYY at XXX.XX.XX.X7>;party=calling;privacy=off;screen=no

   v=0
EXECUTE sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 
set(conference_enforce_security=false)
   o=FreeSWITCH 1270291306 1270291307 IN IP4 XXX.XX.XX.X7
   s=FreeSWITCH
   c=IN IP4 XXX.XX.XX.X7
   t=0 0
   m=audio 21986 RTP/AVP 8 101
   a=rtpmap:8 PCMA/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=silenceSupp:off - - - -
   a=ptime:20
   ------------------------------------------------------------------------
2010-04-03 18:48:12.122631 [DEBUG] sofia.c:4153 Channel 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 entering state [completed][200]
2010-04-03 18:48:12.122631 [DEBUG] mod_dptools.c:816 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 SET 
[conference_enforce_security]=[false]
EXECUTE sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 
conference(49331YYYYYY-XXX.XX.XX.X7 at default)
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'mute' bound to '0'.
2010-04-03 18:48:12.122631 [DEBUG] switch_ivr.c:1616 max len 1
2010-04-03 18:48:12.122631 [DEBUG] switch_ivr.c:1620 min len 1
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'deaf mute' bound to '*'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'energy up' bound to '9'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'energy equ' bound to '8'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'energy dn' bound to '7'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'vol talk up' bound to '3'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'vol talk zero' bound to '2'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'vol talk dn' bound to '1'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'vol listen up' bound to '6'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'vol listen zero' bound to '5'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'vol listen dn' bound to '4'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5671 Installing 
default caller control action 'hangup' bound to '#'.
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:4990 Raw Codec 
Activation Success L16 at 8000hz 1 channel 20ms
2010-04-03 18:48:12.122631 [DEBUG] mod_conference.c:5035 Raw Codec 
Activation Success L16 at 8000hz 1 channel 20ms
2010-04-03 18:48:12.125638 [DEBUG] switch_core_codec.c:122 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Push codec L16:10
2010-04-03 18:48:12.125638 [DEBUG] switch_core_session.c:638 Send signal 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [BREAK]
2010-04-03 18:48:12.125638 [DEBUG] mod_conference.c:2202 Setup timer 
soft success interval: 20  samples: 160
2010-04-03 18:48:12.125638 [DEBUG] mod_conference.c:994 Setup timer 
success interval: 20  samples: 160
recv 445 bytes from udp/[XXX.XX.XX.X6]:5060 at 16:48:12.144223:
   ------------------------------------------------------------------------
   ACK sip:49331YYYYYY at XXX.XX.XX.X7:5060;transport=udp SIP/2.0
   Via: SIP/2.0/UDP 
XXX.XX.XX.X6:5060;branch=z9hG4bK-34ff11004c71ff10ff000024ff0c6dff
   From: 
<sip:49XXXXXXXX6 at XXX.XX.XX.X6;user=phone>;tag=44ff11004c71ff10ff000024ff0c6dff
   To: <sip:49331YYYYYY at XXX.XX.XX.X7:5060;user=phone>;tag=Uv2Z4H5vNFyej
   Call-ID: 9aef11004c71b710800000248c0c6d9e at DOMAIN_ORIG
   CSeq: 1 ACK
   Max-Forwards: 10
   User-Agent: MERA MSIP v.1.0.2
   Content-Length: 0

   ------------------------------------------------------------------------
2010-04-03 18:48:12.143633 [DEBUG] sofia.c:4153 Channel 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 entering state [ready][200]
recv 446 bytes from udp/[XXX.XX.XX.X6]:5060 at 16:48:12.311539:
   ------------------------------------------------------------------------
   BYE sip:49331YYYYYY at XXX.XX.XX.X7:5060;transport=udp SIP/2.0
   Via: SIP/2.0/UDP XXX.XX.XX.X6:5060
   From: 
<sip:49XXXXXXXX6 at XXX.XX.XX.X6;user=phone>;tag=44ff11004c71ff10ff000024ff0c6dff
   To: <sip:49331YYYYYY at XXX.XX.XX.X7:5060;user=phone>;tag=Uv2Z4H5vNFyej
   Call-ID: 9aef11004c71b710800000248c0c6d9e at DOMAIN_ORIG
   CSeq: 2 BYE
   Max-Forwards: 10
   User-Agent: MERA MSIP v.1.0.2
   Reason: Q.850;cause=29;text="Facility rejected"
   Content-Length: 0

   ------------------------------------------------------------------------
2010-04-03 18:48:12.308666 [NOTICE] sofia.c:481 Hangup 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [CS_EXECUTE] [FACILITY_REJECTED]
2010-04-03 18:48:12.308666 [DEBUG] switch_channel.c:2071 Send signal 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [KILL]
2010-04-03 18:48:12.308666 [DEBUG] switch_core_session.c:1018 Send 
signal sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [BREAK]
send 493 bytes to udp/[XXX.XX.XX.X6]:5060 at 16:48:12.311906:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP XXX.XX.XX.X6:5060
   From: 
<sip:49XXXXXXXX6 at XXX.XX.XX.X6;user=phone>;tag=44ff11004c71ff10ff000024ff0c6dff
   To: <sip:49331YYYYYY at XXX.XX.XX.X7:5060;user=phone>;tag=Uv2Z4H5vNFyej
   Call-ID: 9aef11004c71b710800000248c0c6d9e at DOMAIN_ORIG
   CSeq: 2 BYE
   User-Agent: FreeSWITCH-mod_sofia/1.0.git-exportiert
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, 
REGISTER, REFER, NOTIFY
   Supported: timer, precondition, path, replaces
   Content-Length: 0

   ------------------------------------------------------------------------
2010-04-03 18:48:12.326660 [DEBUG] mod_conference.c:2473 Channel leaving 
conference, cause: FACILITY_REJECTED
2010-04-03 18:48:12.329664 [DEBUG] switch_core_codec.c:146 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Restore previous codec PCMA:8.
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:348 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State EXECUTE going to sleep
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:314 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) Running State Change CS_HANGUP
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:499 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State HANGUP
2010-04-03 18:48:12.329664 [DEBUG] mod_sofia.c:408 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Overriding SIP cause 501 with 
200 from the other leg
2010-04-03 18:48:12.329664 [DEBUG] mod_sofia.c:414 Channel 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 hanging up, cause: FACILITY_REJECTED
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:46 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Standard HANGUP, cause: 
FACILITY_REJECTED
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:499 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State HANGUP going to sleep
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:333 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State Change CS_HANGUP -> 
CS_REPORTING
2010-04-03 18:48:12.329664 [DEBUG] switch_core_session.c:1018 Send 
signal sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [BREAK]
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:314 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) Running State Change CS_REPORTING
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:590 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State REPORTING
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:53 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Standard REPORTING, cause: 
FACILITY_REJECTED
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:590 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State REPORTING going to sleep
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:327 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State Change CS_REPORTING -> 
CS_DESTROY
2010-04-03 18:48:12.329664 [DEBUG] switch_core_session.c:1018 Send 
signal sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [BREAK]
2010-04-03 18:48:12.329664 [DEBUG] switch_core_session.c:1161 Session 8 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) Locked, Waiting on external 
entities
2010-04-03 18:48:12.329664 [NOTICE] switch_core_session.c:1179 Session 8 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) Ended
2010-04-03 18:48:12.329664 [NOTICE] switch_core_session.c:1181 Close 
Channel sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 [CS_DESTROY]
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:428 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) Running State Change CS_DESTROY
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:439 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State DESTROY
2010-04-03 18:48:12.329664 [DEBUG] mod_sofia.c:341 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 SOFIA DESTROY
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:60 
sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6 Standard DESTROY
2010-04-03 18:48:12.329664 [DEBUG] switch_core_state_machine.c:439 
(sofia/external/49XXXXXXXX6 at XXX.XX.XX.X6) State DESTROY going to sleep
2010-04-03 18:48:12.347672 [DEBUG] mod_conference.c:1361 Write Lock ON
2010-04-03 18:48:12.347672 [DEBUG] mod_conference.c:1364 Write Lock OFF

Brian West schrieb:
> sofia profile xxxxx siptrace on (replace xxx with the profile)
>
> Then try again.
>
> /b
>
> On Apr 3, 2010, at 10:14 AM, Jan Riedinger wrote:
>
>   
>> However, if I dial in via a voip carrier, the calls are disconnect with 
>> disconnect cause "facility rejected" by the voip carrier. It seems that 
>> Freeswitch tries to change some parameters of the call setup, which is 
>> refused. You find below the console log output. Do you have an idea, 
>> what I have to change to get it working?
>>     
>
>
> _______________________________________________
> FreeSWITCH-users mailing list
> FreeSWITCH-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>   

-- 
Jan Riedinger                           Phone :  +49-30-39 73 19 66
Dipl.-Inf. | Managing Director          Fax   :  +49-30-39 73 19 64
                                        E-Mail:  riedinger at sns.eu
SNS Consult GmbH                        ICQ   :  163-237-041
Südwestkorso 49a                        MSN   :  jan at sns-consult.de
14197 Berlin GERMANY                    Skype :  Jan Riedinger

AG Charlottenburg - HRB 71973




More information about the FreeSWITCH-users mailing list